# 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=1 # 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: 2.018 ns/op # Warmup Iteration 2: 2.014 ns/op # Warmup Iteration 3: 1.890 ns/op # Warmup Iteration 4: 1.922 ns/op # Warmup Iteration 5: 1.894 ns/op Iteration 1: 1.878 ns/op Iteration 2: 1.880 ns/op Iteration 3: 1.878 ns/op Iteration 4: 1.889 ns/op Iteration 5: 1.883 ns/op # Processing profiler results: LinuxPerfAsmProfiler Result "test": 1.882 ±(99.9%) 0.017 ns/op [Average] (min, avg, max) = (1.878, 1.882, 1.889), stdev = 0.004 CI (99.9%): [1.865, 1.899] (assumes normal distribution) Secondary result "·asm": PrintAssembly processed: 107763 total address lines. Perf output processed (skipped 5.084 seconds): Column 1: cycles (7175 events) Column 2: instructions (7249 events) Hottest code regions (>10.00% "cycles" events): ....[Hottest Region 1].............................................................................. [0x7f146583c6db:0x7f146583c74c] in org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub 0x00007f146583c6db: callq 0x00007f147d89f5b0 ;*invokestatic nanoTime {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@7 (line 165) ; {runtime_call} 0x00007f146583c6e0: mov 0x28(%rsp),%rcx 0x00007f146583c6e5: mov %rax,0x28(%rcx) ;*putfield startTime {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@10 (line 165) ; implicit exception: dispatches to 0x00007f146583c773 0x00007f146583c6e9: movabs $0x0,%rdi ;*aload_3 {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@13 (line 167) 0x00007f146583c6f3: nopl 0x0(%rax,%rax,1) 8.13% 7.08% ↗ 0x00007f146583c6f8: mov %rdi,0x40(%rsp) 0.36% 0.57% │ 0x00007f146583c6fd: mov 0x30(%rsp),%r8 1.09% 0.61% │ 0x00007f146583c702: cmp (%r8),%rax ; implicit exception: dispatches to 0x00007f146583c778 3.21% 2.39% │ 0x00007f146583c705: mov %r8,%rsi ;*invokevirtual test {reexecute=0 rethrow=0 return_oop=0} │ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@14 (line 167) 8.42% 8.03% │ 0x00007f146583c708: nopl 0x0(%rax) 0.45% 0.33% │ 0x00007f146583c70f: callq 0x00007f1465231160 ; ImmutableOopMap{[40]=Oop [56]=Oop [48]=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} 18.43% 19.46% │ 0x00007f146583c714: mov 0x40(%rsp),%rdi 1.35% 1.48% │ 0x00007f146583c719: movabs $0x1,%r10 3.30% 3.57% │ 0x00007f146583c723: add %r10,%rdi 7.87% 7.31% │ 0x00007f146583c726: mov 0x38(%rsp),%rdx 0.53% 0.70% │ 0x00007f146583c72b: movsbl 0x94(%rdx),%esi ; ImmutableOopMap{[40]=Oop [48]=Oop rdx=Oop [56]=Oop } │ ;*ifeq {reexecute=1 rethrow=0 return_oop=0} │ ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@27 (line 169) │ ; implicit exception: dispatches to 0x00007f146583c77d 1.76% 1.02% │ 0x00007f146583c732: test %eax,0x193a78c8(%rip) # 0x00007f147ebe4000 │ ; {poll} 3.30% 2.59% │ 0x00007f146583c738: cmp $0x0,%esi ╰ 0x00007f146583c73b: je 0x00007f146583c6f8 ;*ifeq {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@27 (line 169) 0x00007f146583c73d: mov %rdi,0x48(%rsp) 0x00007f146583c742: callq 0x00007f147d89f5b0 ;*invokestatic nanoTime {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@31 (line 170) ; {runtime_call} 0x00007f146583c747: mov 0x28(%rsp),%rcx 0x00007f146583c74c: mov %rax,0x30(%rcx) ;*putfield stopTime {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub@34 (line 170) .................................................................................................... 58.19% 55.14% ....[Hottest Region 2].............................................................................. [0x7f1465834300:0x7f146583435a] in org.openjdk.ThisNull::test [Constants] # {method} {0x00007f13fb8710a8} 'test' '()V' in 'org/openjdk/ThisNull' # [sp+0x50] (sp of caller) 0x00007f1465834300: mov 0x8(%rsi),%r10d 0x00007f1465834304: shl $0x3,%r10 0x00007f1465834308: cmp %rax,%r10 0x00007f146583430b: jne 0x00007f1465230f60 ; {runtime_call ic_miss_stub} 0x00007f1465834311: data16 data16 nopw 0x0(%rax,%rax,1) 0x00007f146583431c: data16 data16 xchg %ax,%ax [Verified Entry Point] 3.76% 3.68% 0x00007f1465834320: mov %eax,-0x14000(%rsp) 8.47% 9.73% 0x00007f1465834327: push %rbp 0.99% 0.28% 0x00007f1465834328: sub $0x40,%rsp ;*aload_0 {reexecute=0 rethrow=0 return_oop=0} ; - org.openjdk.ThisNull::test@0 (line 18) 10.79% 13.28% 0x00007f146583432c: cmp $0x0,%rsi ╭ 0x00007f1465834330: je 0x00007f1465834342 ;*ifnonnull {reexecute=0 rethrow=0 return_oop=0} │ ; - org.openjdk.ThisNull::m@1 (line 22) │ ; - org.openjdk.ThisNull::test@2 (line 18) 0.52% 0.47% │ 0x00007f1465834336: add $0x40,%rsp 1.16% 1.03% │ 0x00007f146583433a: pop %rbp 3.16% 3.71% │ 0x00007f146583433b: test %eax,0x193afcbf(%rip) # 0x00007f147ebe4000 │ ; {poll_return} 8.54% 8.37% │ 0x00007f1465834341: retq ;*return {reexecute=0 rethrow=0 return_oop=0} │ ; - org.openjdk.ThisNull::test@5 (line 19) ↘ 0x00007f1465834342: nopw 0x0(%rax,%rax,1) 0x00007f1465834348: jmpq 0x00007f14658343b5 ; {no_reloc} 0x00007f146583434d: add %al,(%rax) 0x00007f146583434f: add %al,(%rax) 0x00007f1465834351: add %cl,-0x75(%rcx) 0x00007f1465834354: rex.RXB (bad) 0x00007f1465834356: lea 0x20(%rax),%rdi 0x00007f146583435a: cmp 0x70(%r15),%rdi .................................................................................................... 37.39% 40.56% ....[Hottest Regions]............................................................................... 58.19% 55.14% [0x7f146583c6db:0x7f146583c74c] in org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub 37.39% 40.56% [0x7f1465834300:0x7f146583435a] in org.openjdk.ThisNull::test 3.23% 3.19% [0xffffffff8105b83a:0xffffffff8105b83a] in [unknown] ([unknown]) 0.06% 0.06% [0xffffffff810d302e:0xffffffff810d3068] in [unknown] ([unknown]) 0.06% 0.04% [0xffffffff817b3c15:0xffffffff817b3c20] in [unknown] ([unknown]) 0.04% [0xffffffff81091088:0xffffffff81091091] in [unknown] ([unknown]) 0.04% 0.04% [0xffffffff817b5a12:0xffffffff817b5a12] in [unknown] ([unknown]) 0.04% 0.01% [0xffffffff817b5e50:0xffffffff817b5e5c] in [unknown] ([unknown]) 0.03% 0.01% [0xffffffff811ee6e8:0xffffffff811ee6ef] in [unknown] ([unknown]) 0.03% [0xffffffff81209269:0xffffffff81209288] in [unknown] ([unknown]) 0.03% [0xffffffff817b3d99:0xffffffff817b3d99] in [unknown] ([unknown]) 0.03% 0.01% [0xffffffff817b56ab:0xffffffff817b56b1] in [unknown] ([unknown]) 0.03% [0x7f146583a:0x7f147d94d2b0] in sun.reflect.ClassFileAssembler::append 0.03% [0x7f146583a:0x7f147d94d2b0] in sun.reflect.ClassFileAssembler::append 0.03% [0x7f147e4634e6:0x7f147e463504] in _IO_do_write@@GLIBC_2.2.5 (libc-2.19.so) 0.03% 0.01% [0x7f147e4d488d:0x7f147e4d488d] in __GI___libc_write (libc-2.19.so) 0.03% 0.03% [0x7f147e4dd84c:0x7f147e4dd859] in syscall (libc-2.19.so) 0.01% [0xffffffff810a67d5:0xffffffff810a67d5] in [unknown] ([unknown]) 0.01% [0xffffffff810b4466:0xffffffff810b4466] in [unknown] ([unknown]) 0.01% [0xffffffff810bb9c9:0xffffffff810bb9c9] in [unknown] ([unknown]) 0.66% 0.88% <...other 94 warm regions...> .................................................................................................... 100.00% 99.99% ....[Hottest Methods (after inlining)].............................................................. 58.19% 55.14% org.openjdk.generated.ThisNull_test_jmhTest::test_avgt_jmhStub 37.39% 40.56% org.openjdk.ThisNull::test 3.93% 3.79% [unknown] ([unknown]) 0.22% 0.19% sun.reflect.ClassFileAssembler::append 0.04% 0.03% 0.03% 0.03% syscall (libc-2.19.so) 0.03% 0.03% __GI___libc_write (libc-2.19.so) 0.03% _IO_do_write@@GLIBC_2.2.5 (libc-2.19.so) 0.01% 0.03% _IO_fwrite (libc-2.19.so) 0.01% 0.01% pthread_getspecific (libpthread-2.19.so) 0.01% _IO_no_init (libc-2.19.so) 0.01% 0.01% __strchrnul (libc-2.19.so) 0.01% __vsnprintf_chk (libc-2.19.so) 0.01% 0.01% __pthread_mutex_cond_lock (libpthread-2.19.so) 0.01% 0.04% __strchr_sse2 (libc-2.19.so) 0.01% __stpcpy_sse2_unaligned (libc-2.19.so) .................................................................................................... 100.00% 99.85% ....[Distribution by Area].......................................................................... 95.87% 95.92% 3.93% 3.79% 0.17% 0.28% 0.03% .................................................................................................... 100.00% 99.99% # Run complete. Total time: 00:00:16 Benchmark Mode Cnt Score Error Units ThisNull.test avgt 5 1.882 ± 0.017 ns/op ThisNull.test:·asm avgt NaN ---