test/java/lang/ProcessHandle/TreeTest.java failed intermittently with assertion error

This happened in mach 5 testing for latest jdk 9 dev. There are other intermittent issues, such as JDK-8142530. But the error is different in detail.

Please see the following test output:

----------System.out:(133/16648)*----------
[TestNG] Running:
  java/lang/ProcessHandle/TreeTest.java

self pid: 76752
pid 76752, alive: true; parent: Optional[79908], [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:42.955Z], totalTime: Optional[PT0.546875S]]
test TreeTest.test1(): success
  p1 pid: 79468
 waiting for subprocesses of 79468 to start, expected: 3, current: 0
 waiting for subprocesses of 79468 to start, expected: 3, current: 7
test TreeTest.test2(): failure
java.lang.AssertionError: Child should be alive: 824 expected [true] but found [false]
at org.testng.Assert.fail(Assert.java:94)
at org.testng.Assert.failNotEquals(Assert.java:494)
at org.testng.Assert.assertTrue(Assert.java:42)
at TreeTest.test2(TreeTest.java:172)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:520)
at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:84)
at org.testng.internal.Invoker.invokeMethod(Invoker.java:714)
at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:901)
at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:1231)
at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:127)
at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:111)
at org.testng.TestRunner.privateRun(TestRunner.java:767)
at org.testng.TestRunner.run(TestRunner.java:617)
at org.testng.SuiteRunner.runTest(SuiteRunner.java:334)
at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:329)
at org.testng.SuiteRunner.privateRun(SuiteRunner.java:291)
at org.testng.SuiteRunner.run(SuiteRunner.java:240)
at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86)
at org.testng.TestNG.runSuitesSequentially(TestNG.java:1224)
at org.testng.TestNG.runSuitesLocally(TestNG.java:1149)
at org.testng.TestNG.run(TestNG.java:1057)
at com.sun.javatest.regtest.TestNGAction$TestNGRunner.main(TestNGAction.java:163)
at com.sun.javatest.regtest.TestNGAction$TestNGRunner.main(TestNGAction.java:147)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:520)
at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:92)
at java.lang.Thread.run(Thread.java:747)
 p1: 33880
test TreeTest.test3(): success
    Parent Child Info
        null, 0, []
        null, 4, []
        null, 228, [, cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:12.912Z], totalTime: Optional[PT1M7.84375S]]
        null, 576, []
        null, 616, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:13.489Z], totalTime: Optional[PT1H5M5.921875S]]
        null, 684, [, cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:13.361Z], totalTime: Optional[PT20M17.859375S]]
        null, 772, []
        null, 832, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\wininit.exe, startTime: Optional[2015-10-31T13:16:04.387Z], totalTime: Optional[PT0.484375S]]
        null, 932, [, cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:13.664Z], totalTime: Optional[PT11.859375S]]
        null, 1000, [, cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:12.721Z], totalTime: Optional[PT59.21875S]]
        null, 1100, [, cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:13.943Z], totalTime: Optional[PT59.1875S]]
        null, 1316, [, cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:15.228Z], totalTime: Optional[PT22.921875S]]
        null, 1440, [, cmd: C:\\Windows\\System32\\spoolsv.exe, startTime: Optional[2015-10-31T13:16:15.660Z], totalTime: Optional[PT2.515625S]]
        null, 1480, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Program Files (x86)\\McAfee\\Common Framework\\FrameworkService.exe, startTime: Optional[2015-10-31T13:16:15.865Z], totalTime: Optional[PT5M43.234375S]]
        null, 1532, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Program Files (x86)\\McAfee\\VirusScan Enterprise\\vstskmgr.exe, startTime: Optional[2015-10-31T13:16:16.374Z], totalTime: Optional[PT14.4375S]]
        null, 1568, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\mfevtps.exe, startTime: Optional[2015-10-31T13:16:16.955Z], totalTime: Optional[PT1M27.203125S]]
        null, 1664, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Oracle\\agent12c\\core\\12.1.0.4.0\\bin\\nmesrvc.exe, startTime: Optional[2015-10-31T13:16:17.113Z], totalTime: Optional[PT0.609375S]]
        null, 1716, [, cmd: C:\\Program Files\\Microsoft SQL Server\\90\\Shared\\sqlwriter.exe, startTime: Optional[2015-10-31T13:16:17.223Z], totalTime: Optional[PT0.328125S]]
        null, 1884, [user: Optional[SCAAA070\\cyg_server], cmd: C:\\cygwin\\bin\\cygrunsrv.exe, startTime: Optional[2015-10-31T13:16:17.726Z], totalTime: Optional[PT0.25S]]
        null, 1932, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:16:18.352Z], totalTime: Optional[PT16.078125S]]
        null, 1960, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Program Files\\UltraVNC\\winvnc.exe, startTime: Optional[2015-10-31T13:16:18.391Z], totalTime: Optional[PT0.546875S]]
        null, 1980, [user: Optional[SCAAA070\\cyg_server], cmd: C:\\Windows\\System32\\conhost.exe, startTime: Optional[2015-10-31T13:16:18.454Z], totalTime: Optional[PT53M35.578125S]]
        null, 1996, [user: Optional[SCAAA070\\cyg_server], cmd: C:\\cygwin\\usr\\sbin\\sshd.exe, startTime: Optional[2015-10-31T13:16:18.454Z], totalTime: Optional[PT0.140625S]]
        null, 4172, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Program Files\\Common Files\\McAfee\\SystemCore\\mcshield.exe, startTime: Optional[2015-11-04T23:10:57.065Z], totalTime: Optional[PT2M51.921875S]]
        null, 5972, [, cmd: C:\\Windows\\System32\\svchost.exe, startTime: Optional[2015-10-31T13:17:09.032Z], totalTime: Optional[PT8.3125S]]
        null, 6044, [, cmd: C:\\Windows\\System32\\msdtc.exe, startTime: Optional[2015-10-31T13:19:08.903Z], totalTime: Optional[PT0.59375S]]
        null, 6460, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\winlogon.exe, startTime: Optional[2015-11-03T01:43:34.222Z], totalTime: Optional[PT0.328125S]]
        null, 11024, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\Program Files (x86)\\McAfee\\VirusScan Enterprise\\shstat.exe, startTime: Optional[2015-11-03T01:43:51.719Z], totalTime: Optional[PT0.28125S]]
        null, 13284, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\Windows\\explorer.exe, startTime: Optional[2015-11-03T01:43:36.200Z], totalTime: Optional[PT10.265625S]]
        null, 16120, []
        null, 47772, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\cygwin\\bin\\bash.exe, startTime: Optional[2015-11-17T20:22:29.250Z], totalTime: Optional[PT0.03125S]]
        null, 61788, [user: Optional[SCAAA070\\cyg_server], cmd: C:\\cygwin\\usr\\sbin\\sshd.exe, startTime: Optional[2015-11-17T20:22:28.705Z], totalTime: Optional[PT1M4.984375S]]
        null, 71548, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\cygwin\\bin\\bash.exe, startTime: Optional[2015-11-23T20:33:37.420Z], totalTime: Optional[PT0.046875S]]
        null, 80220, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\cygwin\\bin\\bash.exe, startTime: Optional[2015-11-23T20:36:53.332Z], totalTime: Optional[PT0.03125S]]
        null, 82536, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\cygwin\\bin\\sh.exe, startTime: Optional[2015-11-23T20:36:53.753Z], totalTime: Optional[PT0.015625S]]
         616, 27336, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\Windows\\System32\\taskhostex.exe, startTime: Optional[2015-11-03T01:43:35.886Z], totalTime: Optional[PT0.28125S]]
         816, 824, []
         816, 876, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\winlogon.exe, startTime: Optional[2015-10-31T13:16:05.188Z], totalTime: Optional[PT0.65625S]]
         832, 920, []
         832, 928, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\lsass.exe, startTime: Optional[2015-10-31T13:16:08.687Z], totalTime: Optional[PT20M50.890625S]]
         876, 676, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\LogonUI.exe, startTime: Optional[2015-10-31T13:16:13.315Z], totalTime: Optional[PT0.390625S]]
         876, 720, [, cmd: C:\\Windows\\System32\\dwm.exe, startTime: Optional[2015-10-31T13:16:13.394Z], totalTime: Optional[PT0.15625S]]
        1000, 1796, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Program Files (x86)\\McAfee\\Common Framework\\naPrdMgr.exe, startTime: Optional[2015-10-31T13:16:17.395Z], totalTime: Optional[PT1M46.515625S]]
        1000, 4928, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\wbem\\WmiPrvSE.exe, startTime: Optional[2015-10-31T13:16:56.625Z], totalTime: Optional[PT26M43.0625S]]
        1532, 1580, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Program Files (x86)\\McAfee\\VirusScan Enterprise\\mfeann.exe, startTime: Optional[2015-10-31T13:16:17.019Z], totalTime: Optional[PT0.765625S]]
        1580, 1616, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\conhost.exe, startTime: Optional[2015-10-31T13:16:17.050Z], totalTime: Optional[PT0.328125S]]
        1664, 1684, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\conhost.exe, startTime: Optional[2015-10-31T13:16:17.176Z], totalTime: Optional[PT1.4375S]]
        1664, 4784, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Windows\\System32\\cmd.exe, startTime: Optional[2015-10-31T13:16:33.269Z], totalTime: Optional[PT0.25S]]
        1960, 2900, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Program Files\\UltraVNC\\winvnc.exe, startTime: Optional[2015-10-31T13:16:23.686Z], totalTime: Optional[PT0.46875S]]
        4784, 4800, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Oracle\\agent12c\\core\\12.1.0.4.0\\perl\\bin\\perl.exe, startTime: Optional[2015-10-31T13:16:33.427Z], totalTime: Optional[PT1.609375S]]
        4800, 4672, [user: Optional[NT AUTHORITY\\SYSTEM], cmd: C:\\Oracle\\agent12c\\core\\12.1.0.4.0\\jdk\\bin\\java.exe, startTime: Optional[2015-10-31T13:16:44.344Z], totalTime: Optional[PT13M25.984375S]]
        5972, 8572, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\Windows\\System32\\rdpclip.exe, startTime: Optional[2015-11-03T01:43:35.978Z], totalTime: Optional[PT0.484375S]]
        6460, 22852, [, cmd: C:\\Windows\\System32\\dwm.exe, startTime: Optional[2015-11-03T01:43:35.104Z], totalTime: Optional[PT0.796875S]]
       46768, 74624, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\cygwin\\bin\\sh.exe, startTime: Optional[2015-11-23T20:33:37.378Z], totalTime: Optional[PT0S]]
       47772, 64912, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\cygwin\\bin\\bash.exe, startTime: Optional[2015-11-17T20:22:29.263Z], totalTime: Optional[PT0S]]
       51216, 79908, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\mach5\\jdkbuildwrapper\\.data\\unpacked\\jpg\\infra\\builddeps\\jdk-8-windows-i586\\1.0\\jdk1.8.0\\bin\\java.exe, startTime: Optional[2015-11-23T20:36:54.634Z], totalTime: Optional[PT1M10.6875S]]
       64912, 46768, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\java\\jdk1.8.0_25\\bin\\java.exe, startTime: Optional[2015-11-17T20:22:29.270Z], totalTime: Optional[PT2H28M59.875S]]
       76752, 79468, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:43.628Z], totalTime: Optional[PT0.140625S]]
       79468, 816, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:43.773Z], totalTime: Optional[PT0.109375S]]
       79468, 70068, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:43.761Z], totalTime: Optional[PT0.140625S]]
       79468, 77308, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:43.777Z], totalTime: Optional[PT0.125S]]
       79908, 4140, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:40.371Z], totalTime: Optional[PT4.796875S]]
       79908, 20264, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:40.473Z], totalTime: Optional[PT4.484375S]]
       79908, 60008, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:43.336Z], totalTime: Optional[PT1.46875S]]
       79908, 62716, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:42.076Z], totalTime: Optional[PT2.71875S]]
       79908, 63144, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:40.790Z], totalTime: Optional[PT1.640625S]]
       79908, 69452, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:40.897Z], totalTime: Optional[PT2.703125S]]
       79908, 71716, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:41.112Z], totalTime: Optional[PT4S]]
       79908, 75812, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:40.574Z], totalTime: Optional[PT1.078125S]]
       79908, 75892, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:43.349Z], totalTime: Optional[PT1.390625S]]
       79908, 76752, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:42.955Z], totalTime: Optional[PT1.046875S]]
       79908, 77916, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:41.007Z], totalTime: Optional[PT2.65625S]]
       79908, 79052, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:40.265Z], totalTime: Optional[PT4.59375S]]
       79908, 85436, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\jenkins\\workspace\\9-dev-tier2-windows-i586\\build\\jdk\\bin\\java.exe, startTime: Optional[2015-11-23T20:37:40.680Z], totalTime: Optional[PT4.15625S]]
       82536, 51216, [user: Optional[SCAAA070\\mach5-one], cmd: C:\\cygwin\\bin\\sh.exe, startTime: Optional[2015-11-23T20:36:54.627Z], totalTime: Optional[PT0S]]
test TreeTest.test4(): success
Spawning 2 x 2 x 2 processes, pid: 75732
 descendants: [73468, 58492, 59708, 30568, 55584, 51372, 69996, 72780, 71900, 80272, 81276, 84484, 86392, 25508]
Duration: PT0.6034867S
test TreeTest.test5(): success

===============================================
java/lang/ProcessHandle/TreeTest.java
Total tests run: 5, Failures: 1, Skips: 0
===============================================

----------System.err:(14/810)----------
java.lang.Exception: failures: 1
at com.sun.javatest.regtest.TestNGAction$TestNGRunner.main(TestNGAction.java:166)
at com.sun.javatest.regtest.TestNGAction$TestNGRunner.main(TestNGAction.java:147)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:520)
at com.sun.javatest.regtest.agent.MainWrapper$MainThread.run(MainWrapper.java:92)
at java.lang.Thread.run(Thread.java:747)

JavaTest Message: Test threw exception: java.lang.Exception: failures: 1
JavaTest Message: shutting down test