sessions for parallel only # Detecting actual CPU count: 8 detected # JMH 1.17.2 (released 97 days ago) # VM version: JDK 9-internal, VM 9-internal+0-adhoc.zgu.shenandoah-jdk9 # VM invoker: /home/zgu/workspace/shenandoah-jdk9/build/linux-x86_64-normal-server-release/jdk/bin/java # VM options: -XX:+UseShenandoahGC -XX:ConcGCThreads=4 -XX:ParallelGCThreads=4 -XX:+UnlockExperimentalVMOptions -XX:-UseSessionForConcWorkers -XX:-PrintShenandoahWorkGangStats -XX:+UseSessionForParallelWorkers -Xmx1g -Xlog:gc+stats # Warmup: 10 iterations, 3 s each # Measurement: 10 iterations, 1 s each # Timeout: 10 min per iteration # Threads: 8 threads, will synchronize iterations # Benchmark mode: Throughput, ops/time # Benchmark: org.openjdk.specjvm2008.Compiler.sunflow # Run progress: 0.00% complete, ETA 00:00:40 # Fork: 1 of 1 # Warmup Iteration 1: 93.370 ops/min # Warmup Iteration 2: 151.248 ops/min # Warmup Iteration 3: 186.325 ops/min # Warmup Iteration 4: 215.237 ops/min # Warmup Iteration 5: 257.222 ops/min # Warmup Iteration 6: 283.328 ops/min # Warmup Iteration 7: 263.955 ops/min # Warmup Iteration 8: 263.654 ops/min # Warmup Iteration 9: 284.809 ops/min # Warmup Iteration 10: 271.629 ops/min Iteration 1: 265.898 ops/min Iteration 2: 272.730 ops/min Iteration 3: 284.800 ops/min Iteration 4: 277.981 ops/min Iteration 5: 275.890 ops/min Iteration 6: 266.516 ops/min Iteration 7: 272.472 ops/min Iteration 8: 274.199 ops/min Iteration 9: 278.787 ops/min Iteration 10: 270.071 ops/min [120.790s][info][gc,stats] [120.790s][info][gc,stats] GC STATISTICS: [120.790s][info][gc,stats] "gross" pauses include time to safepoint. "net" pauses are times spent in GC. [120.790s][info][gc,stats] "a" is average time for each phase, look at levels to see if average makes sense. [120.790s][info][gc,stats] "lvls" are quantiles: 0% (minimum), 25%, 50% (median), 75%, 100% (maximum). [120.790s][info][gc,stats] [120.790s][info][gc,stats] Total Pauses (gross) = 32.18 s (a = 44383 us) (n = 725) (lvls, us = 873, 1992, 10156, 89258, 238688) [120.790s][info][gc,stats] Total Pauses (net) = 2.29 s (a = 3161 us) (n = 725) (lvls, us = 98, 746, 961, 2832, 80336) [120.790s][info][gc,stats] Initial Mark Pauses (gross) = 0.96 s (a = 2642 us) (n = 364) (lvls, us = 871, 1309, 2031, 3125, 24673) [120.790s][info][gc,stats] Initial Mark Pauses (net) = 0.45 s (a = 1235 us) (n = 364) (lvls, us = 521, 859, 949, 1035, 8514) [120.791s][info][gc,stats] Accumulate Stats = 0.00 s (a = 5 us) (n = 364) (lvls, us = 3, 4, 5, 5, 23) [120.791s][info][gc,stats] Make Parsable = 0.00 s (a = 3 us) (n = 364) (lvls, us = 2, 3, 3, 4, 11) [120.791s][info][gc,stats] Clear Liveness = 0.05 s (a = 131 us) (n = 364) (lvls, us = 21, 125, 143, 150, 198) [120.791s][info][gc,stats] Scan Roots = 0.40 s (a = 1090 us) (n = 364) (lvls, us = 404, 709, 789, 881, 8469) [120.791s][info][gc,stats] S: Thread Roots = 0.04 s (a = 112 us) (n = 367) (lvls, us = 42, 62, 77, 117, 1637) [120.791s][info][gc,stats] S: String Table Roots = 0.10 s (a = 278 us) (n = 367) (lvls, us = 0, 305, 338, 367, 453) [120.791s][info][gc,stats] S: Universe Roots = 0.00 s (a = 2 us) (n = 367) (lvls, us = 1, 2, 2, 2, 3) [120.791s][info][gc,stats] S: JNI Roots = 0.00 s (a = 7 us) (n = 367) (lvls, us = 3, 5, 6, 7, 24) [120.791s][info][gc,stats] S: JNI Weak Roots = 0.02 s (a = 64 us) (n = 367) (lvls, us = 0, 60, 73, 86, 149) [120.791s][info][gc,stats] S: Synchronizer Roots = 0.00 s (a = 4 us) (n = 367) (lvls, us = 2, 3, 4, 4, 8) [120.791s][info][gc,stats] S: Flat Profiler Roots = 0.00 s (a = 1 us) (n = 367) (lvls, us = 0, 1, 1, 1, 1) [120.791s][info][gc,stats] S: Management Roots = 0.00 s (a = 1 us) (n = 367) (lvls, us = 0, 1, 1, 1, 2) [120.791s][info][gc,stats] S: System Dict Roots = 0.01 s (a = 28 us) (n = 367) (lvls, us = 8, 11, 13, 17, 124) [120.791s][info][gc,stats] S: CLDG Roots = 0.08 s (a = 229 us) (n = 367) (lvls, us = 117, 209, 234, 254, 489) [120.791s][info][gc,stats] S: JVMTI Roots = 0.00 s (a = 1 us) (n = 367) (lvls, us = 0, 0, 0, 1, 9) [120.791s][info][gc,stats] Resize TLABs = 0.00 s (a = 4 us) (n = 367) (lvls, us = 2, 3, 4, 5, 29) [120.791s][info][gc,stats] Final Mark Pauses (gross) = 31.22 s (a = 86469 us) (n = 361) (lvls, us = 2930, 67188, 89453, 103516, 238687) [120.791s][info][gc,stats] Final Mark Pauses (net) = 1.84 s (a = 5103 us) (n = 361) (lvls, us = 98, 664, 1836, 6445, 80336) [120.791s][info][gc,stats] Update Roots = 0.20 s (a = 544 us) (n = 361) (lvls, us = 0, 432, 465, 508, 5187) [120.791s][info][gc,stats] U: Thread Roots = 0.03 s (a = 82 us) (n = 360) (lvls, us = 28, 49, 56, 68, 921) [120.791s][info][gc,stats] U: String Table Roots = 0.06 s (a = 168 us) (n = 360) (lvls, us = 127, 158, 164, 172, 232) [120.791s][info][gc,stats] U: Universe Roots = 0.00 s (a = 1 us) (n = 360) (lvls, us = 0, 1, 1, 1, 1) [120.791s][info][gc,stats] U: JNI Roots = 0.00 s (a = 4 us) (n = 360) (lvls, us = 2, 3, 3, 4, 19) [120.791s][info][gc,stats] U: JNI Weak Roots = 0.01 s (a = 15 us) (n = 360) (lvls, us = 6, 12, 14, 17, 58) [120.791s][info][gc,stats] U: Synchronizer Roots = 0.00 s (a = 5 us) (n = 360) (lvls, us = 3, 3, 4, 4, 205) [120.791s][info][gc,stats] U: Flat Profiler Roots = 0.00 s (a = 1 us) (n = 360) (lvls, us = 0, 1, 1, 1, 1) [120.791s][info][gc,stats] U: Management Roots = 0.00 s (a = 1 us) (n = 360) (lvls, us = 1, 1, 1, 1, 2) [120.791s][info][gc,stats] U: System Dict Roots = 0.00 s (a = 7 us) (n = 360) (lvls, us = 5, 6, 7, 8, 13) [120.791s][info][gc,stats] U: CLDG Roots = 0.05 s (a = 146 us) (n = 360) (lvls, us = 82, 129, 146, 162, 222) [120.791s][info][gc,stats] U: JVMTI Roots = 0.00 s (a = 0 us) (n = 360) (lvls, us = 0, 0, 0, 0, 4) [120.791s][info][gc,stats] Drain SATB = 0.99 s (a = 2749 us) (n = 361) (lvls, us = 46, 86, 113, 703, 79835) [120.791s][info][gc,stats] Weak References = 0.15 s (a = 424 us) (n = 361) (lvls, us = 0, 0, 0, 0, 3302) [120.791s][info][gc,stats] Class Unloading = 0.50 s (a = 1384 us) (n = 361) (lvls, us = 17, 68, 74, 89, 8863) [120.791s][info][gc,stats] Prepare Evacuation = 26.90 s (a = 74503 us) (n = 361) (lvls, us = 1094, 56836, 77930, 94336, 232730) [120.791s][info][gc,stats] Initial Evacuation = 2.04 s (a = 5641 us) (n = 361) (lvls, us = 1289, 5098, 5664, 6152, 9331) [120.791s][info][gc,stats] E: Thread Roots = 0.03 s (a = 78 us) (n = 361) (lvls, us = 34, 57, 63, 71, 741) [120.791s][info][gc,stats] E: Code Cache Roots = 0.70 s (a = 1928 us) (n = 361) (lvls, us = 318, 1777, 1992, 2188, 3374) [120.791s][info][gc,stats] Concurrent Marking = 49.65 s (a = 136413 us) (n = 364) (lvls, us = 10547, 107422, 138672, 166016, 237821) [120.791s][info][gc,stats] Concurrent Evacuation = 5.56 s (a = 15409 us) (n = 361) (lvls, us = 221, 5234, 11914, 24023, 73154) [120.791s][info][gc,stats] Reset Bitmaps = 0.55 s (a = 1532 us) (n = 361) (lvls, us = 68, 510, 664, 953, 36365) [120.791s][info][gc,stats] Full GC = 1.15 s (a = 382662 us) (n = 3) (lvls, us = 367188, 367188, 367188, 382812, 395576) [120.791s][info][gc,stats] Heap Dumps = 0.00 s (a = 1 us) (n = 6) (lvls, us = 1, 1, 1, 1, 1) [120.791s][info][gc,stats] Prepare = 0.00 s (a = 1069 us) (n = 3) (lvls, us = 975, 975, 975, 979, 1252) [120.791s][info][gc,stats] Mark = 0.21 s (a = 69909 us) (n = 3) (lvls, us = 59766, 59766, 59766, 70117, 79641) [120.791s][info][gc,stats] Drain Queues = 0.18 s (a = 58552 us) (n = 3) (lvls, us = 46484, 46484, 46484, 59961, 69008) [120.791s][info][gc,stats] Weak References = 0.01 s (a = 2295 us) (n = 3) (lvls, us = 1973, 1973, 1973, 2148, 2750) [120.791s][info][gc,stats] Class Unloading = 0.02 s (a = 8125 us) (n = 3) (lvls, us = 6875, 6875, 6875, 7207, 10290) [120.791s][info][gc,stats] Calculate Addresses = 0.05 s (a = 18141 us) (n = 3) (lvls, us = 17578, 17578, 17578, 17969, 18779) [120.791s][info][gc,stats] Adjust Pointers = 0.14 s (a = 46302 us) (n = 3) (lvls, us = 41211, 41211, 41211, 48047, 49371) [120.791s][info][gc,stats] Copy Objects = 0.74 s (a = 246676 us) (n = 3) (lvls, us = 244141, 244141, 244141, 246094, 248364) [120.791s][info][gc,stats] [120.791s][info][gc,stats] 3 allocation failure and 0 user requested GCs [120.791s][info][gc,stats] 319 successful and 42 degenerated concurrent markings [120.791s][info][gc,stats] Result "sunflow": 273.934 ±(99.9%) 8.729 ops/min [Average] (min, avg, max) = (265.898, 273.934, 284.800), stdev = 5.774 CI (99.9%): [265.205, 282.663] (assumes normal distribution) # Run complete. Total time: 00:02:00 Benchmark Mode Cnt Score Error Units Compiler.sunflow thrpt 10 273.934 ± 8.729 ops/min