eclipse-openj9 / openj9

Eclipse OpenJ9: A Java Virtual Machine for OpenJDK that's optimized for small footprint, fast start-up, and high throughput. Builds on Eclipse OMR (https://github.com/eclipse/omr) and combines with the Extensions for OpenJDK for OpenJ9 repo.
Other
3.23k stars 712 forks source link

JDK8 renaissance-future-genetic_0 NPE #12548

Open JasonFengJ9 opened 3 years ago

JasonFengJ9 commented 3 years ago

Failure link

From an internal build Test_openjdk8_j9_sanity.perf_ppc64le_linux/44/

openjdk version "1.8.0_292-internal"
OpenJDK Runtime Environment (build 1.8.0_292-internal-202104230402-b10)
Eclipse OpenJ9 VM (build master-f296ae765, JRE 1.8.0 Linux ppc64le-64-Bit Compressed References 20210423_98 (JIT enabled, AOT enabled)
OpenJ9   - f296ae765
OMR      - 22a4853ac
JCL      - 2c626fee based on jdk8u292-b10)

Rerun in Grinder

Optional info

Failure output (captured from console output)

[2021-04-23T05:16:02.642Z] Running test renaissance-future-genetic_0 ...
[2021-04-23T05:16:02.642Z] ===============================================
[2021-04-23T05:16:02.642Z] renaissance-future-genetic_0 Start Time: Thu Apr 22 22:14:35 2021 Epoch Time (ms): 1619154875837
[2021-04-23T05:16:02.642Z] "/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64le_linux/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:destroyAll; "/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64le_linux/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:groupAccess,destroyAll; echo "cache cleanup done";
[2021-04-23T05:16:02.642Z] JVMSHRC005I No shared class caches available
[2021-04-23T05:16:02.642Z] JVMSHRC005I No shared class caches available
[2021-04-23T05:16:02.642Z] cache cleanup done
[2021-04-23T05:16:02.642Z] variation: NoOptions
[2021-04-23T05:16:02.642Z] JVM_OPTIONS:  
[2021-04-23T05:16:02.642Z] ====== future-genetic (jdk-concurrent), iteration 0 started ======
[2021-04-23T05:16:02.642Z] Exception occurred in org.renaissance.jdk.concurrent.FutureGenetic@67b5d186: java.lang.NullPointerException
[2021-04-23T05:16:02.642Z] java.util.concurrent.CompletionException: java.lang.NullPointerException
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:273)
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:280)
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1606)
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.CompletableFuture$AsyncSupply.exec(CompletableFuture.java:1596)
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:289)
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1056)
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1692)
[2021-04-23T05:16:02.642Z]  at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:175)
[2021-04-23T05:16:02.642Z] Caused by: java.lang.NullPointerException
[2021-04-23T05:16:02.642Z]  at java.util.Objects.requireNonNull(Objects.java:203)
[2021-04-23T05:16:02.642Z]  at io.jenetics.engine.Timer.of(Timer.java:87)
[2021-04-23T05:16:02.642Z]  at io.jenetics.engine.TimedResult.lambda$of$0(TimedResult.java:59)
[2021-04-23T05:16:02.642Z]  at io.jenetics.engine.TimedResult$$Lambda$149/0x0000000000000000.get(Unknown Source)
[2021-04-23T05:16:02.642Z]  at io.jenetics.engine.Engine.evolve(Engine.java:327)
[2021-04-23T05:16:02.643Z]  at io.jenetics.engine.Engine$$Lambda$117/0x0000000000000000.apply(Unknown Source)
[2021-04-23T05:16:02.643Z]  at io.jenetics.internal.engine.EvolutionSpliterator.tryAdvance(EvolutionSpliterator.java:75)
[2021-04-23T05:16:02.643Z]  at java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:126)
[2021-04-23T05:16:02.643Z]  at java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:514)
[2021-04-23T05:16:02.643Z]  at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:501)
[2021-04-23T05:16:02.643Z]  at java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:487)
[2021-04-23T05:16:02.643Z]  at java.util.stream.ReduceOps$ReduceOp.evaluateSequential(ReduceOps.java:708)
[2021-04-23T05:16:02.643Z]  at java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:241)
[2021-04-23T05:16:02.643Z]  at java.util.stream.ReferencePipeline.collect(ReferencePipeline.java:566)
[2021-04-23T05:16:02.643Z]  at org.renaissance.jdk.concurrent.JavaJenetics.evolveChromosome(JavaJenetics.java:85)
[2021-04-23T05:16:02.643Z]  at org.renaissance.jdk.concurrent.JavaJenetics$$Lambda$99/0x0000000000000000.get(Unknown Source)
[2021-04-23T05:16:02.643Z]  at java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1604)
[2021-04-23T05:16:02.643Z]  ... 5 more
[2021-04-23T05:16:02.643Z] The following benchmarks failed: future-genetic
[2021-04-23T05:16:02.643Z] 
[2021-04-23T05:16:02.643Z] renaissance-future-genetic_0_FAILED
pshipton commented 3 years ago

Is this intermittent?

JasonFengJ9 commented 3 years ago

Is this intermittent?

Yes, first & only time from test history.

Edit: 30x grinder all passed at Test_grinder/job/Grinder/15031/

JasonFengJ9 commented 3 years ago

A different error appeared in this test at Test_openjdk8_j9_sanity.perf_ppc64_aix/68 IncompatibleClassChangeError: java/time/Clock.instant()Ljava/time/Instant; (loaded from /home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdkbinary/j2sdk-image/jre/lib/rt.jar by <Bootstrap Loader>) called from class io.jenetics.engine.Timer (loaded from file:/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdk-tests/TKG/output_162263567617/renaissance-future-genetic_0/./tmp-jars-4058080339689372780/cp-7723495267439593619.jar by java.net.URLClassLoader@bcda5aa5).

openjdk version "1.8.0_302-internal"
OpenJDK Runtime Environment (build 1.8.0_302-internal-202106020235-b04)
Eclipse OpenJ9 VM (build master-4d607679e, JRE 1.8.0 AIX ppc64-64-Bit Compressed References 20210601_138 (JIT enabled, AOT enabled)
OpenJ9   - 4d607679e
OMR      - c086f1671
JCL      - 82bd60f0 based on jdk8u302-b04)

[2021-06-02T11:01:58.095Z] Running test renaissance-future-genetic_0 ...
[2021-06-02T11:01:58.095Z] ===============================================
[2021-06-02T11:01:58.095Z] renaissance-future-genetic_0 Start Time: Wed Jun  2 07:12:37 2021 Epoch Time (ms): 1622635957449
[2021-06-02T11:01:58.095Z] "/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:destroyAll; "/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdkbinary/j2sdk-image/bin/java" -Xshareclasses:groupAccess,destroyAll; echo "cache cleanup done";
[2021-06-02T11:01:58.095Z] JVMSHRC005I No shared class caches available
[2021-06-02T11:01:58.095Z] JVMSHRC005I No shared class caches available
[2021-06-02T11:01:58.096Z] cache cleanup done
[2021-06-02T11:01:58.096Z] variation: NoOptions
[2021-06-02T11:01:58.096Z] JVM_OPTIONS:  

[2021-06-02T11:02:16.835Z] Exception occurred in org.renaissance.jdk.concurrent.FutureGenetic@51845a2d: java.lang.IncompatibleClassChangeError: java/time/Clock.instant()Ljava/time/Instant; (loaded from /home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdkbinary/j2sdk-image/jre/lib/rt.jar by <Bootstrap Loader>) called from class io.jenetics.engine.Timer (loaded from file:/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdk-tests/TKG/output_162263567617/renaissance-future-genetic_0/./tmp-jars-4058080339689372780/cp-7723495267439593619.jar by java.net.URLClassLoader@bcda5aa5).
[2021-06-02T11:02:16.835Z] java.util.concurrent.CompletionException: java.lang.IncompatibleClassChangeError: java/time/Clock.instant()Ljava/time/Instant; (loaded from /home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdkbinary/j2sdk-image/jre/lib/rt.jar by <Bootstrap Loader>) called from class io.jenetics.engine.Timer (loaded from file:/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdk-tests/TKG/output_162263567617/renaissance-future-genetic_0/./tmp-jars-4058080339689372780/cp-7723495267439593619.jar by java.net.URLClassLoader@bcda5aa5).
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.CompletableFuture.encodeThrowable(CompletableFuture.java:273)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.CompletableFuture.completeThrowable(CompletableFuture.java:280)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1606)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.CompletableFuture$AsyncSupply.exec(CompletableFuture.java:1596)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.ForkJoinTask.doExec(ForkJoinTask.java:289)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.ForkJoinPool$WorkQueue.runTask(ForkJoinPool.java:1056)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.ForkJoinPool.runWorker(ForkJoinPool.java:1692)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.ForkJoinWorkerThread.run(ForkJoinWorkerThread.java:175)
[2021-06-02T11:02:16.835Z] Caused by: java.lang.IncompatibleClassChangeError: java/time/Clock.instant()Ljava/time/Instant; (loaded from /home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdkbinary/j2sdk-image/jre/lib/rt.jar by <Bootstrap Loader>) called from class io.jenetics.engine.Timer (loaded from file:/home/jenkins/workspace/Test_openjdk8_j9_sanity.perf_ppc64_aix/openjdk-tests/TKG/output_162263567617/renaissance-future-genetic_0/./tmp-jars-4058080339689372780/cp-7723495267439593619.jar by java.net.URLClassLoader@bcda5aa5).
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.Timer.nanos(Timer.java:94)
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.Timer.lambda$of$0(Timer.java:90)
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.Timer$$Lambda$210/0x0000000000000000.getAsLong(Unknown Source)
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.Timer.start(Timer.java:55)
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.TimedResult.lambda$of$0(TimedResult.java:59)
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.TimedResult$$Lambda$156/0x0000000000000000.get(Unknown Source)
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.Engine.evolve(Engine.java:327)
[2021-06-02T11:02:16.835Z]  at io.jenetics.engine.Engine$$Lambda$123/0x0000000000000000.apply(Unknown Source)
[2021-06-02T11:02:16.835Z]  at io.jenetics.internal.engine.EvolutionSpliterator.tryAdvance(EvolutionSpliterator.java:75)
[2021-06-02T11:02:16.835Z]  at java.util.stream.ReferencePipeline.forEachWithCancel(ReferencePipeline.java:126)
[2021-06-02T11:02:16.835Z]  at java.util.stream.AbstractPipeline.copyIntoWithCancel(AbstractPipeline.java:514)
[2021-06-02T11:02:16.835Z]  at java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:501)
[2021-06-02T11:02:16.835Z]  at java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:487)
[2021-06-02T11:02:16.835Z]  at java.util.stream.ReduceOps$ReduceOp.evaluateSequential(ReduceOps.java:708)
[2021-06-02T11:02:16.835Z]  at java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:241)
[2021-06-02T11:02:16.835Z]  at java.util.stream.ReferencePipeline.collect(ReferencePipeline.java:566)
[2021-06-02T11:02:16.835Z]  at org.renaissance.jdk.concurrent.JavaJenetics.evolveChromosome(JavaJenetics.java:85)
[2021-06-02T11:02:16.835Z]  at org.renaissance.jdk.concurrent.JavaJenetics$$Lambda$99/0x0000000000000000.get(Unknown Source)
[2021-06-02T11:02:16.835Z]  at java.util.concurrent.CompletableFuture$AsyncSupply.run(CompletableFuture.java:1604)
[2021-06-02T11:02:16.835Z]  ... 5 more
[2021-06-02T11:02:16.835Z] The following benchmarks failed: future-genetic
[2021-06-02T11:02:17.642Z] 
[2021-06-02T11:02:17.642Z] renaissance-future-genetic_0_FAILED

Rerun in Grinder