Bug in G1 logging?

[Mikael Gerdin]

Thomas,

On 2015-06-15 11:08, Thomas Viessmann wrote:
> Hi Mikael,
>
> OK. Nevertheless it's confusing if the vast amount of [Other] does not show
> up in its sub-categories. How about adding another [Other] in there? :-D

We are thinking about revamping this, the problem is that the current 
code depends on manually recording which times are accounted and not.
The plan is to build something which can automatically give "other" 
times and specify between which accounted phases these other times occurred.

Thanks for the feedback!
/Mikael

>
> Thanks and Regards
>
> Thomas
>
> On 15/06/2015 10:52, Mikael Gerdin wrote:
>> Hi Thomas,
>>
>> On 2015-06-15 10:41, Thomas Viessmann wrote:
>>> Hi all,
>>>
>>> There is probably a bug in G1 logging in 8u40. The total of [Other:
>>> 214.0 ms]
>>> does not match the sum  of its sub-categories which amount to just
>>> 9.2 ms.
>>> Hence at least one of these is supposedly wrong. Is this a known bug or
>>> should I file
>>> a new one?
>>
>> This is not a bug, there may be unmeasured phases during the GC which
>> can take unexpected amounts of time.
>>
>> /Mikael
>>
>>>
>>>    [Code Root Fixup: 0.1 ms]
>>>     [Code Root Purge: 0.0 ms]
>>>     [Clear CT: 2.0 ms]
>>>     [Other: 214.0 ms]<<<<<<<<<<<<<<<<<<
>>>        [Choose CSet: 0.0 ms]
>>>        [Ref Proc: 4.9 ms]
>>>        [Ref Enq: 0.3 ms]
>>>        [Redirty Cards: 2.1 ms]
>>>           [Parallel Redirty:  1.8  1.8  1.7  1.7  1.7  1.7 1.7 1.7 1.7
>>> 1.7  1.6  1.6  1.6
>>>            Min: 1.6, Avg: 1.7, Max: 1.8, Diff: 0.2, Sum: 22.1]
>>>           [Redirtied Cards:  27319  24512  23040  24635 18996 28913
>>> 20628  19163  17881  17664  15360  18417  16639
>>>            Min: 15360, Avg: 21012.8, Max: 28913, Diff: 13553, Sum:
>>> 273167]
>>>        [Humongous Reclaim: 0.0 ms]
>>>           [Humongous Total: 11]
>>>           [Humongous Candidate: 0]
>>>           [Humongous Reclaimed: 0]
>>>        [Free CSet: 1.9 ms]
>>>           [Young Free CSet: 1.9 ms]
>>>           [Non-Young Free CSet: 0.0 ms]
>>>     [Eden: 3400.0M(3232.0M)->0.0B(848.0M) Survivors: 176.0M->376.0M
>>> Heap: 12.6G(24.0G)->9673.3M(24.0G)]
>>>
>>>
>>>
>>> Thanks and Regards
>>>
>>> Thomas
>>>
>
> --
> Oracle <http://www.oracle.com>
> THOMAS VIESSMANN | Senior Principal Technical Support Engineer - Java
> Phone: +498914302496 <tel:+49814302496> | Mobile: +491743005467
> <tel:+491743005467>
> Oracle Customer Technical Support - Java
>
> ORACLE Deutschland B.V. & Co. KG | Riesstr.25 | D-80992 Muenchen
>
> ORACLE Deutschland B.V. & Co. KG
> Hauptverwaltung: Riesstr. 25, D-80992 Muenchen
> Registergericht: Amtsgericht Muenchen, HRA 95603
>
> Komplementärin: ORACLE Deutschland Verwaltung B.V.
> Hertogswetering 163/167, 3543 AS Utrecht, Niederlande
> Handelsregister der Handelskammer Midden-Niederlande, Nr. 30143697
> Geschäftsführer: Alexander van der Ven, Astrid Kepper, Val Maher
>
> ------------------------------------------------------------------------
> ------------------------------------------------------------------------
> Green Oracle <http://www.oracle.com/commitment> Oracle is committed to
> developing practices and products that help protect the environment