RFR(S/M): 8217659 monitor_logging updates from Async Monitor Deflation project

Daniel D. Daugherty daniel.daugherty at oracle.com
Sun Jan 27 03:10:17 UTC 2019


Greetings,

I've updated the patch to resolve code review comments from David H.
and Coleen. I've also rebased the patch to the jdk/jdk repo at the
'jdk-13+5' tag (plus the 8217658 patch); there were no merge surprises.

Here's an incremental webrev:

http://cr.openjdk.java.net/~dcubed/8217659-webrev/1-for-jdk13.inc/

I've also generated a full webrev since the changes to synchronizer.cpp
are extensive and that's the easier way to review it:

http://cr.openjdk.java.net/~dcubed/8217659-webrev/1-for-jdk13.full/

This patch along with 8217658 have been through Mach5
builds-tier1,hs-tier1,jdk-tier1,hs-tier2,hs-tier3 testing with
no failures.

Thanks, in advance, for any questions, comments or suggestions.

Dan

P.S.
I've attached sample output for running Hello.java with the
monitorinflation logging enabled at Info, Debug and Trace.


On 1/23/19 3:16 PM, Daniel D. Daugherty wrote:
> Greetings,
>
> I have a (S)mall/(M)edium patch extracted from the Async Monitor 
> Deflation
> project that is ready for code review. I'm calling this a 
> (S)mall/(M)edium
> because the logic changes are (S)mall, but the logging code is tedious 
> and
> there's a bunch of it in audit_and_print_stats() so (M)edium.
>
> The short version of what this patch is about:
>
>     This sub-task captures updates and additions to the
>     baseline monitor logging code.
>
> The details are in the bug report:
>
>     JDK-8217659 monitor_logging updates from Async Monitor Deflation 
> project
>     https://bugs.openjdk.java.net/browse/JDK-8217659
>
> Here's the webrev:
>
>     http://cr.openjdk.java.net/~dcubed/8217659-webrev/0-for-jdk13/
>
> This patch along with the other two patches for Async Monitor Deflation
> project have been through Mach5 
> builds-tier1,hs-tier1,jdk-tier1,hs-tier2,hs-tier3
> testing and I'm currently running my stress testing kits on my Linux-X64
> and Solaris-X64 servers.
>
> I have been actively using this new logging code while debugging my
> port of the Async Monitor Deflation project code.
>
> Thanks, in advance, for any questions, comments or suggestions.
>
> Dan
>
>

-------------- next part --------------
[0.105s][info][monitorinflation] deflating per-thread idle monitors, 0.0000021 secs, 2 monitors
Hello world!
[0.141s][info][monitorinflation]      Global Lists:       InUse        Free       Total
[0.141s][info][monitorinflation] ==================  ==========  ==========  ==========
[0.141s][info][monitorinflation]                              0          33         127
[0.141s][info][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.141s][info][monitorinflation] ==================  ==========  ==========  ==========
[0.141s][info][monitorinflation] 0x00007fdd8c030800           0          31          49
[0.141s][info][monitorinflation] 0x00007fdd8c929800           1          30          49
[0.141s][info][monitorinflation] 0x00007fdd8c03e000           0           0          32
[0.141s][info][monitorinflation] 0x00007fdd8c959000           0           0          32
[0.141s][info][monitorinflation] 0x00007fdd8c931000           0           0          32
[0.141s][info][monitorinflation] 0x00007fdd8c03c000           0           0          32
[0.141s][info][monitorinflation] 0x00007fdd8c920800           1          31          49
[0.141s][info][monitorinflation] Checking global lists:
[0.141s][info][monitorinflation] gMonitorPopulation=127 equals ckMonitorPopulation=127
[0.141s][info][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.141s][info][monitorinflation] gMonitorFreeCount=33 equals ckMonitorFreeCount=33
[0.141s][info][monitorinflation] Checking per-thread lists:
[0.141s][info][monitorinflation] jt=0x00007fdd8c030800: omInUseCount=0 equals ckOmInUseCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c030800: omFreeCount=31 equals ckOmFreeCount=31
[0.141s][info][monitorinflation] jt=0x00007fdd8c929800: omInUseCount=1 equals ckOmInUseCount=1
[0.141s][info][monitorinflation] jt=0x00007fdd8c929800: omFreeCount=30 equals ckOmFreeCount=30
[0.141s][info][monitorinflation] jt=0x00007fdd8c03e000: omInUseCount=0 equals ckOmInUseCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c03e000: omFreeCount=0 equals ckOmFreeCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c959000: omInUseCount=0 equals ckOmInUseCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c959000: omFreeCount=0 equals ckOmFreeCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c931000: omInUseCount=0 equals ckOmInUseCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c931000: omFreeCount=0 equals ckOmFreeCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c03c000: omInUseCount=0 equals ckOmInUseCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c03c000: omFreeCount=0 equals ckOmFreeCount=0
[0.141s][info][monitorinflation] jt=0x00007fdd8c920800: omInUseCount=1 equals ckOmInUseCount=1
[0.141s][info][monitorinflation] jt=0x00007fdd8c920800: omFreeCount=31 equals ckOmFreeCount=31
[0.141s][info][monitorinflation] No errors found in monitor list checks.
[0.141s][info][monitorinflation] In-use per-thread monitor info:
[0.141s][info][monitorinflation] (B -> is_busy, H -> has hashcode, L -> lock status)
[0.141s][info][monitorinflation]                 jt             monitor  BHL              object         object type
[0.141s][info][monitorinflation] ==================  ==================  ===  ==================  ==================
[0.141s][info][monitorinflation] 0x00007fdd8c929800  0x00007fdd8c035580  100  0x000000070ff02790  java.lang.ref.ReferenceQueue$Lock
[0.141s][info][monitorinflation] 0x00007fdd8c920800  0x00007fdd8c037480  100  0x000000070ff90b50  java.lang.ref.ReferenceQueue$Lock
-------------- next part --------------
[0.245s][debug][monitorinflation] deflating global idle monitors, 0.0000001 secs, 0 monitors
[0.245s][info ][monitorinflation] deflating per-thread idle monitors, 0.0000021 secs, 1 monitors
[0.245s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.245s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.245s][info ][monitorinflation]                              0          96         127
[0.245s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.245s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.245s][info ][monitorinflation] 0x00007fccbb00c000           0           0          32
[0.245s][info ][monitorinflation] 0x00007fccbb102800           0           0          32
[0.245s][info ][monitorinflation] 0x00007fccbb106000           1          30          49
[0.245s][info ][monitorinflation] 0x00007fccbb104800           0           0          32
[0.245s][info ][monitorinflation] 0x00007fccbb112000           0           0          32
[0.245s][info ][monitorinflation] 0x00007fccbc001000           0           0          32
[0.245s][info ][monitorinflation] 0x00007fccbc004000           0           0          32
[0.245s][info ][monitorinflation] 0x00007fccbc002000           0           0          32
[0.245s][info ][monitorinflation] Checking global lists:
[0.245s][info ][monitorinflation] gMonitorPopulation=127 equals ckMonitorPopulation=127
[0.245s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] gMonitorFreeCount=96 equals ckMonitorFreeCount=96
[0.245s][info ][monitorinflation] Checking per-thread lists:
[0.245s][info ][monitorinflation] jt=0x00007fccbb00c000: omInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbb00c000: omFreeCount=0 equals ckOmFreeCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbb102800: omInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbb102800: omFreeCount=0 equals ckOmFreeCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbb106000: omInUseCount=1 equals ckOmInUseCount=1
[0.245s][info ][monitorinflation] jt=0x00007fccbb106000: omFreeCount=30 equals ckOmFreeCount=30
[0.245s][info ][monitorinflation] jt=0x00007fccbb104800: omInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbb104800: omFreeCount=0 equals ckOmFreeCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbb112000: omInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbb112000: omFreeCount=0 equals ckOmFreeCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbc001000: omInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbc001000: omFreeCount=0 equals ckOmFreeCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbc004000: omInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbc004000: omFreeCount=0 equals ckOmFreeCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbc002000: omInUseCount=0 equals ckOmInUseCount=0
[0.245s][info ][monitorinflation] jt=0x00007fccbc002000: omFreeCount=0 equals ckOmFreeCount=0
[0.245s][info ][monitorinflation] No errors found in monitor list checks.
[0.266s][debug][monitorinflation] deflating global idle monitors, 0.0000001 secs, 0 monitors
[0.266s][debug][monitorinflation] deflating per-thread idle monitors, 0.0000011 secs, 0 monitors
[0.266s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.266s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.266s][info ][monitorinflation]                              0          96         127
[0.266s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.266s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.266s][info ][monitorinflation] 0x00007fccbb00c000           0           0          32
[0.266s][info ][monitorinflation] 0x00007fccbb102800           0           0          32
[0.266s][info ][monitorinflation] 0x00007fccbb106000           1          30          49
[0.266s][info ][monitorinflation] 0x00007fccbb104800           0           0          32
[0.266s][info ][monitorinflation] 0x00007fccbb112000           0           0          32
[0.266s][info ][monitorinflation] 0x00007fccbc001000           0           0          32
[0.266s][info ][monitorinflation] 0x00007fccbc004000           0           0          32
[0.266s][info ][monitorinflation] 0x00007fccbc002000           0           0          32
[0.266s][info ][monitorinflation] 0x00007fccbb110000           0           0          32
[0.266s][info ][monitorinflation] Checking global lists:
[0.266s][info ][monitorinflation] gMonitorPopulation=127 equals ckMonitorPopulation=127
[0.266s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] gMonitorFreeCount=96 equals ckMonitorFreeCount=96
[0.266s][info ][monitorinflation] Checking per-thread lists:
[0.266s][info ][monitorinflation] jt=0x00007fccbb00c000: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb00c000: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb102800: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb102800: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb106000: omInUseCount=1 equals ckOmInUseCount=1
[0.266s][info ][monitorinflation] jt=0x00007fccbb106000: omFreeCount=30 equals ckOmFreeCount=30
[0.266s][info ][monitorinflation] jt=0x00007fccbb104800: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb104800: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb112000: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb112000: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbc001000: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbc001000: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbc004000: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbc004000: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbc002000: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbc002000: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb110000: omInUseCount=0 equals ckOmInUseCount=0
[0.266s][info ][monitorinflation] jt=0x00007fccbb110000: omFreeCount=0 equals ckOmFreeCount=0
[0.266s][info ][monitorinflation] No errors found in monitor list checks.
Hello world!
[0.300s][debug][monitorinflation] deflating global idle monitors, 0.0000001 secs, 0 monitors
[0.301s][debug][monitorinflation] deflating per-thread idle monitors, 0.0000017 secs, 0 monitors
[0.301s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.301s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.301s][info ][monitorinflation]                              0          64         127
[0.301s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.301s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.301s][info ][monitorinflation] 0x00007fccbb102800           0           0          32
[0.301s][info ][monitorinflation] 0x00007fccbb106000           1          30          49
[0.301s][info ][monitorinflation] 0x00007fccbb112000           0           0          32
[0.301s][info ][monitorinflation] 0x00007fccbc001000           0           0          32
[0.301s][info ][monitorinflation] 0x00007fccbc004000           0           0          32
[0.301s][info ][monitorinflation] 0x00007fccbc002000           0           0          32
[0.301s][info ][monitorinflation] 0x00007fccbb110000           1          31          49
[0.301s][info ][monitorinflation] Checking global lists:
[0.301s][info ][monitorinflation] gMonitorPopulation=127 equals ckMonitorPopulation=127
[0.301s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.301s][info ][monitorinflation] gMonitorFreeCount=64 equals ckMonitorFreeCount=64
[0.301s][info ][monitorinflation] Checking per-thread lists:
[0.301s][info ][monitorinflation] jt=0x00007fccbb102800: omInUseCount=0 equals ckOmInUseCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbb102800: omFreeCount=0 equals ckOmFreeCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbb106000: omInUseCount=1 equals ckOmInUseCount=1
[0.301s][info ][monitorinflation] jt=0x00007fccbb106000: omFreeCount=30 equals ckOmFreeCount=30
[0.301s][info ][monitorinflation] jt=0x00007fccbb112000: omInUseCount=0 equals ckOmInUseCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbb112000: omFreeCount=0 equals ckOmFreeCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbc001000: omInUseCount=0 equals ckOmInUseCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbc001000: omFreeCount=0 equals ckOmFreeCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbc004000: omInUseCount=0 equals ckOmInUseCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbc004000: omFreeCount=0 equals ckOmFreeCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbc002000: omInUseCount=0 equals ckOmInUseCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbc002000: omFreeCount=0 equals ckOmFreeCount=0
[0.301s][info ][monitorinflation] jt=0x00007fccbb110000: omInUseCount=1 equals ckOmInUseCount=1
[0.301s][info ][monitorinflation] jt=0x00007fccbb110000: omFreeCount=31 equals ckOmFreeCount=31
[0.301s][info ][monitorinflation] No errors found in monitor list checks.
[0.324s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.324s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.324s][info ][monitorinflation]                              0          64         127
[0.324s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.324s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.324s][info ][monitorinflation] 0x00007fccbb102800           0           0          32
[0.324s][info ][monitorinflation] 0x00007fccbb106000           1          30          49
[0.324s][info ][monitorinflation] 0x00007fccbb112000           0           0          32
[0.324s][info ][monitorinflation] 0x00007fccbc001000           0           0          32
[0.324s][info ][monitorinflation] 0x00007fccbc004000           0           0          32
[0.324s][info ][monitorinflation] 0x00007fccbc002000           0           0          32
[0.324s][info ][monitorinflation] 0x00007fccbb110000           1          31          49
[0.324s][info ][monitorinflation] Checking global lists:
[0.324s][info ][monitorinflation] gMonitorPopulation=127 equals ckMonitorPopulation=127
[0.324s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.324s][info ][monitorinflation] gMonitorFreeCount=64 equals ckMonitorFreeCount=64
[0.324s][info ][monitorinflation] Checking per-thread lists:
[0.324s][info ][monitorinflation] jt=0x00007fccbb102800: omInUseCount=0 equals ckOmInUseCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbb102800: omFreeCount=0 equals ckOmFreeCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbb106000: omInUseCount=1 equals ckOmInUseCount=1
[0.324s][info ][monitorinflation] jt=0x00007fccbb106000: omFreeCount=30 equals ckOmFreeCount=30
[0.324s][info ][monitorinflation] jt=0x00007fccbb112000: omInUseCount=0 equals ckOmInUseCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbb112000: omFreeCount=0 equals ckOmFreeCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbc001000: omInUseCount=0 equals ckOmInUseCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbc001000: omFreeCount=0 equals ckOmFreeCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbc004000: omInUseCount=0 equals ckOmInUseCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbc004000: omFreeCount=0 equals ckOmFreeCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbc002000: omInUseCount=0 equals ckOmInUseCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbc002000: omFreeCount=0 equals ckOmFreeCount=0
[0.324s][info ][monitorinflation] jt=0x00007fccbb110000: omInUseCount=1 equals ckOmInUseCount=1
[0.324s][info ][monitorinflation] jt=0x00007fccbb110000: omFreeCount=31 equals ckOmFreeCount=31
[0.324s][info ][monitorinflation] No errors found in monitor list checks.
[0.324s][info ][monitorinflation] In-use per-thread monitor info:
[0.324s][info ][monitorinflation] (B -> is_busy, H -> has hashcode, L -> lock status)
[0.324s][info ][monitorinflation]                 jt             monitor  BHL              object         object type
[0.324s][info ][monitorinflation] ==================  ==================  ===  ==================  ==================
[0.324s][info ][monitorinflation] 0x00007fccbb106000  0x00007fccbb108d80  100  0x000000070ff02790  java.lang.ref.ReferenceQueue$Lock
[0.324s][info ][monitorinflation] 0x00007fccbb110000  0x00007fccbb10ad80  100  0x000000070ff90b50  java.lang.ref.ReferenceQueue$Lock
-------------- next part --------------
[0.054s][trace][monitorinflation] inflate(has_locker): object=0x000000070ff00250, mark=0x00007fa136004282, type='[I'
[0.054s][trace][monitorinflation] inflate(has_locker): object=0x000000070ff01ee0, mark=0x00007fa13490d882, type='java.lang.Object'
[0.063s][trace][monitorinflation] inflate(has_locker): object=0x000000070ff02790, mark=0x00007fa13490d782, type='java.lang.ref.ReferenceQueue$Lock'
[0.114s][trace][monitorinflation] deflate_monitor: object=0x000000070ff00250, mark=0x00007fa136004282, type='[I'
[0.114s][trace][monitorinflation] deflate_monitor: object=0x000000070ff01ee0, mark=0x00007fa13490d882, type='java.lang.Object'
[0.114s][info ][monitorinflation] deflating global idle monitors, 0.0000001 secs, 0 monitors
[0.114s][info ][monitorinflation] deflating per-thread idle monitors, 0.0000277 secs, 2 monitors
[0.114s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.114s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.114s][info ][monitorinflation]                              0         160         254
[0.114s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.114s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.114s][info ][monitorinflation] 0x00007fa135006000           0          32          49
[0.114s][info ][monitorinflation] 0x00007fa134906800           0          31          49
[0.114s][info ][monitorinflation] 0x00007fa13600e800           1          30          49
[0.114s][info ][monitorinflation] 0x00007fa135807800           0           0          32
[0.114s][info ][monitorinflation] 0x00007fa13580b000           0           0          32
[0.114s][info ][monitorinflation] 0x00007fa13480d000           0           0          32
[0.114s][info ][monitorinflation] 0x00007fa134913000           0           0          32
[0.114s][info ][monitorinflation] 0x00007fa136010000           0           0          32
[0.114s][info ][monitorinflation] Checking global lists:
[0.114s][info ][monitorinflation] gMonitorPopulation=254 equals ckMonitorPopulation=254
[0.114s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] gMonitorFreeCount=160 equals ckMonitorFreeCount=160
[0.114s][info ][monitorinflation] Checking per-thread lists:
[0.114s][info ][monitorinflation] jt=0x00007fa135006000: omInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa135006000: omFreeCount=32 equals ckOmFreeCount=32
[0.114s][info ][monitorinflation] jt=0x00007fa134906800: omInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa134906800: omFreeCount=31 equals ckOmFreeCount=31
[0.114s][info ][monitorinflation] jt=0x00007fa13600e800: omInUseCount=1 equals ckOmInUseCount=1
[0.114s][info ][monitorinflation] jt=0x00007fa13600e800: omFreeCount=30 equals ckOmFreeCount=30
[0.114s][info ][monitorinflation] jt=0x00007fa135807800: omInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa135807800: omFreeCount=0 equals ckOmFreeCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa13580b000: omInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa13580b000: omFreeCount=0 equals ckOmFreeCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa13480d000: omInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa13480d000: omFreeCount=0 equals ckOmFreeCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa134913000: omInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa134913000: omFreeCount=0 equals ckOmFreeCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa136010000: omInUseCount=0 equals ckOmInUseCount=0
[0.114s][info ][monitorinflation] jt=0x00007fa136010000: omFreeCount=0 equals ckOmFreeCount=0
[0.114s][info ][monitorinflation] No errors found in monitor list checks.
[0.114s][info ][monitorinflation] In-use per-thread monitor info:
[0.114s][info ][monitorinflation] (B -> is_busy, H -> has hashcode, L -> lock status)
[0.114s][info ][monitorinflation]                 jt             monitor  BHL              object         object type
[0.114s][info ][monitorinflation] ==================  ==================  ===  ==================  ==================
[0.114s][info ][monitorinflation] 0x00007fa13600e800  0x00007fa13490d780  100  0x000000070ff02790  java.lang.ref.ReferenceQueue$Lock
[0.126s][info ][monitorinflation] deflating global idle monitors, 0.0000001 secs, 0 monitors
[0.127s][debug][monitorinflation] deflating per-thread idle monitors, 0.0000011 secs, 0 monitors
[0.127s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.127s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.127s][info ][monitorinflation]                              0         160         254
[0.127s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.127s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.127s][info ][monitorinflation] 0x00007fa135006000           0          32          49
[0.127s][info ][monitorinflation] 0x00007fa134906800           0          31          49
[0.127s][info ][monitorinflation] 0x00007fa13600e800           1          30          49
[0.127s][info ][monitorinflation] 0x00007fa135807800           0           0          32
[0.127s][info ][monitorinflation] 0x00007fa13580b000           0           0          32
[0.127s][info ][monitorinflation] 0x00007fa13480d000           0           0          32
[0.127s][info ][monitorinflation] 0x00007fa134913000           0           0          32
[0.127s][info ][monitorinflation] 0x00007fa136010000           0           0          32
[0.127s][info ][monitorinflation] 0x00007fa136011000           0           0          32
[0.127s][info ][monitorinflation] Checking global lists:
[0.127s][info ][monitorinflation] gMonitorPopulation=254 equals ckMonitorPopulation=254
[0.127s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] gMonitorFreeCount=160 equals ckMonitorFreeCount=160
[0.127s][info ][monitorinflation] Checking per-thread lists:
[0.127s][info ][monitorinflation] jt=0x00007fa135006000: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa135006000: omFreeCount=32 equals ckOmFreeCount=32
[0.127s][info ][monitorinflation] jt=0x00007fa134906800: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa134906800: omFreeCount=31 equals ckOmFreeCount=31
[0.127s][info ][monitorinflation] jt=0x00007fa13600e800: omInUseCount=1 equals ckOmInUseCount=1
[0.127s][info ][monitorinflation] jt=0x00007fa13600e800: omFreeCount=30 equals ckOmFreeCount=30
[0.127s][info ][monitorinflation] jt=0x00007fa135807800: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa135807800: omFreeCount=0 equals ckOmFreeCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa13580b000: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa13580b000: omFreeCount=0 equals ckOmFreeCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa13480d000: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa13480d000: omFreeCount=0 equals ckOmFreeCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa134913000: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa134913000: omFreeCount=0 equals ckOmFreeCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa136010000: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa136010000: omFreeCount=0 equals ckOmFreeCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa136011000: omInUseCount=0 equals ckOmInUseCount=0
[0.127s][info ][monitorinflation] jt=0x00007fa136011000: omFreeCount=0 equals ckOmFreeCount=0
[0.127s][info ][monitorinflation] No errors found in monitor list checks.
[0.127s][info ][monitorinflation] In-use per-thread monitor info:
[0.127s][info ][monitorinflation] (B -> is_busy, H -> has hashcode, L -> lock status)
[0.127s][info ][monitorinflation]                 jt             monitor  BHL              object         object type
[0.127s][info ][monitorinflation] ==================  ==================  ===  ==================  ==================
[0.127s][info ][monitorinflation] 0x00007fa13600e800  0x00007fa13490d780  100  0x000000070ff02790  java.lang.ref.ReferenceQueue$Lock
[0.127s][trace][monitorinflation] inflate(has_locker): object=0x000000070ff90b80, mark=0x00007fa13490f682, type='java.lang.ref.ReferenceQueue$Lock'
Hello world!
[0.139s][info ][monitorinflation] deflating global idle monitors, 0.0000001 secs, 0 monitors
[0.139s][debug][monitorinflation] deflating per-thread idle monitors, 0.0000015 secs, 0 monitors
[0.139s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.139s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.139s][info ][monitorinflation]                              0         160         254
[0.139s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.139s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.139s][info ][monitorinflation] 0x00007fa134906800           0          31          49
[0.139s][info ][monitorinflation] 0x00007fa13600e800           1          30          49
[0.139s][info ][monitorinflation] 0x00007fa13580b000           0           0          32
[0.139s][info ][monitorinflation] 0x00007fa13480d000           0           0          32
[0.139s][info ][monitorinflation] 0x00007fa134913000           0           0          32
[0.139s][info ][monitorinflation] 0x00007fa136010000           0           0          32
[0.139s][info ][monitorinflation] 0x00007fa136011000           1          31          49
[0.139s][info ][monitorinflation] Checking global lists:
[0.139s][info ][monitorinflation] gMonitorPopulation=254 equals ckMonitorPopulation=254
[0.139s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.139s][info ][monitorinflation] gMonitorFreeCount=160 equals ckMonitorFreeCount=160
[0.139s][info ][monitorinflation] Checking per-thread lists:
[0.139s][info ][monitorinflation] jt=0x00007fa134906800: omInUseCount=0 equals ckOmInUseCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa134906800: omFreeCount=31 equals ckOmFreeCount=31
[0.139s][info ][monitorinflation] jt=0x00007fa13600e800: omInUseCount=1 equals ckOmInUseCount=1
[0.139s][info ][monitorinflation] jt=0x00007fa13600e800: omFreeCount=30 equals ckOmFreeCount=30
[0.139s][info ][monitorinflation] jt=0x00007fa13580b000: omInUseCount=0 equals ckOmInUseCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa13580b000: omFreeCount=0 equals ckOmFreeCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa13480d000: omInUseCount=0 equals ckOmInUseCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa13480d000: omFreeCount=0 equals ckOmFreeCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa134913000: omInUseCount=0 equals ckOmInUseCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa134913000: omFreeCount=0 equals ckOmFreeCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa136010000: omInUseCount=0 equals ckOmInUseCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa136010000: omFreeCount=0 equals ckOmFreeCount=0
[0.139s][info ][monitorinflation] jt=0x00007fa136011000: omInUseCount=1 equals ckOmInUseCount=1
[0.139s][info ][monitorinflation] jt=0x00007fa136011000: omFreeCount=31 equals ckOmFreeCount=31
[0.139s][info ][monitorinflation] No errors found in monitor list checks.
[0.139s][info ][monitorinflation] In-use per-thread monitor info:
[0.139s][info ][monitorinflation] (B -> is_busy, H -> has hashcode, L -> lock status)
[0.139s][info ][monitorinflation]                 jt             monitor  BHL              object         object type
[0.139s][info ][monitorinflation] ==================  ==================  ===  ==================  ==================
[0.139s][info ][monitorinflation] 0x00007fa13600e800  0x00007fa13490d780  100  0x000000070ff02790  java.lang.ref.ReferenceQueue$Lock
[0.139s][info ][monitorinflation] 0x00007fa136011000  0x00007fa13490f680  100  0x000000070ff90b80  java.lang.ref.ReferenceQueue$Lock
[0.155s][info ][monitorinflation]      Global Lists:       InUse        Free       Total
[0.155s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.155s][info ][monitorinflation]                              0         160         254
[0.155s][info ][monitorinflation]  Per-Thread Lists:       InUse        Free   Provision
[0.155s][info ][monitorinflation] ==================  ==========  ==========  ==========
[0.155s][info ][monitorinflation] 0x00007fa134906800           0          31          49
[0.155s][info ][monitorinflation] 0x00007fa13600e800           1          30          49
[0.155s][info ][monitorinflation] 0x00007fa13580b000           0           0          32
[0.155s][info ][monitorinflation] 0x00007fa13480d000           0           0          32
[0.155s][info ][monitorinflation] 0x00007fa134913000           0           0          32
[0.155s][info ][monitorinflation] 0x00007fa136010000           0           0          32
[0.155s][info ][monitorinflation] 0x00007fa136011000           1          31          49
[0.155s][info ][monitorinflation] Checking global lists:
[0.155s][info ][monitorinflation] gMonitorPopulation=254 equals ckMonitorPopulation=254
[0.155s][info ][monitorinflation] gOmInUseCount=0 equals ckOmInUseCount=0
[0.155s][info ][monitorinflation] gMonitorFreeCount=160 equals ckMonitorFreeCount=160
[0.155s][info ][monitorinflation] Checking per-thread lists:
[0.155s][info ][monitorinflation] jt=0x00007fa134906800: omInUseCount=0 equals ckOmInUseCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa134906800: omFreeCount=31 equals ckOmFreeCount=31
[0.155s][info ][monitorinflation] jt=0x00007fa13600e800: omInUseCount=1 equals ckOmInUseCount=1
[0.155s][info ][monitorinflation] jt=0x00007fa13600e800: omFreeCount=30 equals ckOmFreeCount=30
[0.155s][info ][monitorinflation] jt=0x00007fa13580b000: omInUseCount=0 equals ckOmInUseCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa13580b000: omFreeCount=0 equals ckOmFreeCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa13480d000: omInUseCount=0 equals ckOmInUseCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa13480d000: omFreeCount=0 equals ckOmFreeCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa134913000: omInUseCount=0 equals ckOmInUseCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa134913000: omFreeCount=0 equals ckOmFreeCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa136010000: omInUseCount=0 equals ckOmInUseCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa136010000: omFreeCount=0 equals ckOmFreeCount=0
[0.155s][info ][monitorinflation] jt=0x00007fa136011000: omInUseCount=1 equals ckOmInUseCount=1
[0.155s][info ][monitorinflation] jt=0x00007fa136011000: omFreeCount=31 equals ckOmFreeCount=31
[0.155s][info ][monitorinflation] No errors found in monitor list checks.
[0.155s][info ][monitorinflation] In-use per-thread monitor info:
[0.155s][info ][monitorinflation] (B -> is_busy, H -> has hashcode, L -> lock status)
[0.155s][info ][monitorinflation]                 jt             monitor  BHL              object         object type
[0.155s][info ][monitorinflation] ==================  ==================  ===  ==================  ==================
[0.155s][info ][monitorinflation] 0x00007fa13600e800  0x00007fa13490d780  100  0x000000070ff02790  java.lang.ref.ReferenceQueue$Lock
[0.155s][info ][monitorinflation] 0x00007fa136011000  0x00007fa13490f680  100  0x000000070ff90b80  java.lang.ref.ReferenceQueue$Lock


More information about the hotspot-runtime-dev mailing list