Wyjaśnienie sprawozdania dziennika Tomcat GC

Question

Oto oświadczenie z mojej catalina.out, generowanych przez mój serwer tomcat:

1885.855: [GC [PSYoungGen: 742996K-> 64359K (761472K)] 2509583K-> 1832973K (4116928K), 0,1453610 sekund] [Czasy: użytkownik = 0,31 sys = 0,00, rzeczywisty = 0,14 s]

Czy ktoś mógłby wyjaśnić znaczenie różnych liczb tutaj?

Answer 1

Rozpad linii jest tak followd:

1885.85 - to w ciągu kilku sekund jest ilość czasu JVM został uruchomiony, tak około 31 minut lub więc w Twoim przypadku, w którym momencie GC wziął miejsce.

[GC - stwierdza, że ​​GC wystąpił w tym momencie. Jest to częściowa GC, czasami pokaże Full GC

Teraz Razem Heap dostępne dla JVM = Młoda + Starego

[PSYoungGen:742996K->64359K(761472K) - reprezentuje Parallel Scavenging Collector w młodym pokoleniu (co jest jednym z wielu typy kolektorów GC dostępnych w JVM).

pamięć zwolniona za pomocą GC jest zawsze wzór

x->y(z) 

x jest początkowy pamięci przed GC, Y oznacza pamięci po GC Z jest całkowitą pamięci pozostawiono do tego obszaru JVM

więc w przykładzie, 742996K->64359K(761472K) - całkowita wielkość jest 761Mb młodych, a gdy osiągnął 742 Mb zbiór odbył ND nie usunięte do 64.3Mb to jest wyjaśnione 678 Mb

2509583K->1832973K(4116928K) 

Tutaj całkowita ilość pamięci sterty jest reprezentowana. Tak więc z ogólnej możliwej sterty 4,1 Gb, kiedy GC miało miejsce, wypełniło się 2,5 Gb i spadło do 1,83 Gb - ponownie to samo 678 Mb zostało usunięte.

0.1453610 secs] 

Cała ta operacja trwała 0.1453610 sekund

[Times: user=0.31 sys=0.00, real=0.14 secs] 

pokazuje rozpad user, system and real times podjęte.

To jest tylko jedna linia - można byłoby patrząc na wzór szczególnie jeden, który mówi Full GC w nim I użyć analizatora dziennika jak GCViewer dla pokazujący przepustowość i inne dobre rzeczy.

Przeczytaj także numer docs from Sun, aby poznać podstawy.

Dalsze czytanie:

http://sujitpal.blogspot.com/2006/08/charting-jvm-garbage-collection.html

Java Garbage Collection Log messages