# JMH 1.11.2 (released 1 days ago) # VM version: JDK 1.9.0-internal, VM 1.9.0-internal-shade_2015_10_30_12_43-b00 # VM invoker: /home/shade/trunks/jdk9-dev-afu/build/linux-x86_64-normal-server-release/images/jdk/bin/java # VM options: -XX:TieredStopAtLevel=4 # Warmup: 5 iterations, 1 s each # Measurement: 5 iterations, 1 s each # Timeout: 10 min per iteration # Threads: 1 thread, will synchronize iterations # Benchmark mode: Average time, time/op # Benchmark: org.openjdk.ThisNull.test # Run progress: 0.00% complete, ETA 00:00:10 # Fork: 1 of 1 # Preparing profilers: LinuxPerfAsmProfiler # Profilers consume stdout and stderr from target VM, use -v EXTRA to copy to console # Warmup Iteration 1: 1.808 ns/op # Warmup Iteration 2: 1.701 ns/op # Warmup Iteration 3: 1.807 ns/op # Warmup Iteration 4: 1.704 ns/op # Warmup Iteration 5: 1.693 ns/op Iteration 1: 1.749 ns/op Iteration 2: 1.693 ns/op Iteration 3: 1.690 ns/op Iteration 4: 1.691 ns/op Iteration 5: 1.688 ns/op # Processing profiler results: LinuxPerfAsmProfiler Result "test": 1.702 ±(99.9%) 0.101 ns/op [Average] (min, avg, max) = (1.688, 1.702, 1.749), stdev = 0.026 CI (99.9%): [1.601, 1.804] (assumes normal distribution) Secondary result "·asm": PrintAssembly processed: 148685 total address lines. Perf output processed (skipped 5.111 seconds): Column 1: cycles (7341 events) Column 2: instructions (7319 events) Hottest code regions (>10.00% "cycles" events): ....[Hottest Region 1].............................................................................. [0x7f67d5541e60:0x7f67d5541e9f] in org.openjdk.ThisNull::test # {method} {0x00007f676589d130} 'test' '()V' in 'org/openjdk/ThisNull' # [sp+0x20] (sp of caller) 0x00007f67d5541e60: mov 0x8(%rsi),%r10d 0x00007f67d5541e64: shl $0x3,%r10 0x00007f67d5541e68: cmp %r10,%rax 0x00007f67d5541e6b: jne 0x00007f67cda97f60 ; {runtime_call ic_miss_stub} 0x00007f67d5541e71: data16 xchg %ax,%ax 0x00007f67d5541e74: nopl 0x0(%rax,%rax,1) 0x00007f67d5541e7c: data16 data16 xchg %ax,%ax [Verified Entry Point] 13.84% 7.75% 0x00007f67d5541e80: sub $0x18,%rsp 0.31% 0.26% 0x00007f67d5541e87: mov %rbp,0x10(%rsp) ;*synchronization entry ; - org.openjdk.ThisNull::test@-1 (line 18) 0.18% 0.05% 0x00007f67d5541e8c: add $0x10,%rsp 13.85% 16.41% 0x00007f67d5541e90: pop %rbp 39.98% 54.52% 0x00007f67d5541e91: test %eax,0x13669169(%rip) # 0x00007f67e8bab000 ; {poll_return} 0.03% 0.03% 0x00007f67d5541e97: retq 0x00007f67d5541e98: hlt 0x00007f67d5541e99: hlt 0x00007f67d5541e9a: hlt 0x00007f67d5541e9b: hlt 0x00007f67d5541e9c: hlt 0x00007f67d5541e9d: hlt 0x00007f67d5541e9e: hlt 0x00007f67d5541e9f: hlt [Exception Handler] .................................................................................................... 68.19% 79.01% ....[Hottest Region 2].............................................................................. [0x7f67d55444e8:0x7f67d554453d] in org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub 0x00007f67d55444e8: mov 0x10(%rsp),%r10 0x00007f67d55444ed: movzbl 0x94(%r10),%r10d ;*getfield isDone {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@24 (line 169) ; implicit exception: dispatches to 0x00007f67d5544585 0x00007f67d55444f5: mov $0x1,%ebp 0x00007f67d55444fa: test %r10d,%r10d ╭ 0x00007f67d55444fd: jne 0x00007f67d5544528 ;*ifeq {reexecute=0 rethrow=0 return_oop=0} │ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@27 (line 169) │ 0x00007f67d55444ff: nop ;*aload_3 {reexecute=0 rethrow=0 return_oop=0} │ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@13 (line 167) 13.61% 6.26% │↗ 0x00007f67d5544500: mov 0x8(%rsp),%rsi 0.04% ││ 0x00007f67d5544505: xchg %ax,%ax 0.01% ││ 0x00007f67d5544507: callq 0x00007f67cda98160 ; ImmutableOopMap{[0]=Oop [8]=Oop [16]=Oop } ││ ;*invokevirtual test {reexecute=0 rethrow=0 return_oop=0} ││ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@14 (line 167) ││ ; {optimized virtual_call} 0.05% 0.03% ││ 0x00007f67d554450c: mov 0x10(%rsp),%r10 13.27% 10.29% ││ 0x00007f67d5544511: movzbl 0x94(%r10),%r10d ;*getfield isDone {reexecute=0 rethrow=0 return_oop=0} ││ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@24 (line 169) 0.16% 0.15% ││ 0x00007f67d5544519: add $0x1,%rbp ; ImmutableOopMap{[0]=Oop [8]=Oop [16]=Oop } ││ ;*ifeq {reexecute=1 rethrow=0 return_oop=0} ││ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@27 (line 169) 0.03% ││ 0x00007f67d554451d: test %eax,0x13666add(%rip) # 0x00007f67e8bab000 ││ ; {poll} 0.03% 0.05% ││ 0x00007f67d5544523: test %r10d,%r10d │╰ 0x00007f67d5544526: je 0x00007f67d5544500 ;*aload_2 {reexecute=0 rethrow=0 return_oop=0} │ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@30 (line 170) ↘ 0x00007f67d5544528: movabs $0x7f67e78665b0,%r10 0x00007f67d5544532: callq *%r10 ;*invokestatic nanoTime {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@31 (line 170) 0x00007f67d5544535: mov (%rsp),%r10 0x00007f67d5544539: mov %rbp,0x18(%r10) ;*putfield measuredOps {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@46 (line 172) 0x00007f67d554453d: mov %rax,0x30(%r10) ;*putfield stopTime {reexecute=0 rethrow=0 return_oop=0} .................................................................................................... 27.12% 16.86% ....[Hottest Regions]............................................................................... 68.19% 79.01% [0x7f67d5541e60:0x7f67d5541e9f] in org.openjdk.ThisNull::test 27.12% 16.86% [0x7f67d55444e8:0x7f67d554453d] in org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub 1.21% 1.30% [0x7f67d5543f06:0x7f67d5543f84] in org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub 0.90% 0.85% [0xffffffff8105b83a:0xffffffff8105b83a] in [unknown] ([unknown]) 0.14% 0.01% [0xffffffff817b5e50:0xffffffff817b5e5c] in [unknown] ([unknown]) 0.11% [0xffffffff817b6f10:0xffffffff817b6f10] in [unknown] ([unknown]) 0.07% 0.07% [0xffffffff810d303a:0xffffffff810d305c] in [unknown] ([unknown]) 0.07% [0xffffffff817b3c20:0xffffffff817b3c20] in [unknown] ([unknown]) 0.07% 0.01% [0xffffffff817b3d85:0xffffffff817b3d99] in [unknown] ([unknown]) 0.05% 0.03% [0xffffffff811ee751:0xffffffff811ee775] in [unknown] ([unknown]) 0.05% 0.01% [0xffffffff817b57ac:0xffffffff817b57c4] in [unknown] ([unknown]) 0.04% 0.04% [0xffffffff810eda3e:0xffffffff810eda3e] in [unknown] ([unknown]) 0.04% 0.03% [0xffffffff811ee6e8:0xffffffff811ee6f6] in [unknown] ([unknown]) 0.04% 0.05% [0xffffffff817b5a00:0xffffffff817b5a12] in [unknown] ([unknown]) 0.03% [0xffffffff8101ae52:0xffffffff8101ae60] in [unknown] ([unknown]) 0.03% [0xffffffff810aa2b8:0xffffffff810aa2c8] in [unknown] ([unknown]) 0.03% [0xffffffff810bb481:0xffffffff810bb498] in [unknown] ([unknown]) 0.03% [0xffffffff810bba77:0xffffffff810bba77] in [unknown] ([unknown]) 0.03% [0xffffffff81218167:0xffffffff81218167] in [unknown] ([unknown]) 0.03% [0xffffffff817b5a9e:0xffffffff817b5a9e] in [unknown] ([unknown]) 1.73% 1.71% <...other 210 warm regions...> .................................................................................................... 100.00% 99.99% ....[Hottest Methods (after inlining)].............................................................. 68.19% 79.01% org.openjdk.ThisNull::test 28.33% 18.16% org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub 2.70% 1.83% [unknown] ([unknown]) 0.37% 0.48% sun.reflect.ClassFileAssembler::cpi 0.08% 0.08% vfprintf (libc-2.19.so) 0.04% 0.01% _ZN9xmlStream10write_textEPKcm (libjvm.so) 0.03% 0.01% _IO_fwrite (libc-2.19.so) 0.03% 0.01% syscall (libc-2.19.so) 0.03% 0.05% _IO_default_xsputn (libc-2.19.so) 0.03% 0.01% __strchrnul (libc-2.19.so) 0.03% 0.01% __GI___libc_write (libc-2.19.so) 0.03% 0.01% _IO_file_xsputn@@GLIBC_2.2.5 (libc-2.19.so) 0.03% 0.01% sun.misc.Unsafe::compareAndSwapInt 0.01% 0.01% strlen (libc-2.19.so) 0.01% [unknown] (perf-19628.map) 0.01% 0.01% _IO_str_init_static_internal (libc-2.19.so) 0.01% java.lang.ClassLoader::loadClass 0.01% 0.01% __stpcpy_sse2_unaligned (libc-2.19.so) 0.01% _ZN21SimpleThresholdPolicy5eventE12methodHandleS0_ii9CompLevelP7nmethodP10JavaThread (libjvm.so) .................................................................................................... 100.00% 99.74% ....[Distribution by Area].......................................................................... 96.95% 97.69% 2.70% 1.83% 0.29% 0.44% 0.05% 0.01% 0.01% .................................................................................................... 100.00% 99.99% # Run complete. Total time: 00:00:17 Benchmark Mode Cnt Score Error Units ThisNull.test avgt 5 1.702 ± 0.101 ns/op ThisNull.test:·asm avgt NaN ---