hya1109 opened a new issue #2431:
URL: https://github.com/apache/rocketmq/issues/2431
As the title, 'Stopping threads took' time is very long.
version :rocketmq 4.4.0
JVM parameters :
java -server -Xms8g -Xmx8g -Xmn4g -XX:+UseG1GC -XX:G1HeapRegionSize=16m
-XX:G1ReservePercent=25 -XX:InitiatingHeapOccupancyPercent=30
-XX:SoftRefLRUPolicyMSPerMB=0 -verbose:gc -Xloggc:/dev/shm/mq_gc_%p.log
-XX:+PrintGCDetails -XX:+PrintGCDateStamps -XX:+PrintGCApplicationStoppedTime
-XX:+PrintAdaptiveSizePolicy -XX:+UseGCLogFileRotation -XX:NumberOfGCLogFiles=5
-XX:GCLogFileSize=30m -XX:-OmitStackTraceInFastThrow -XX:+AlwaysPreTouch
-XX:MaxDirectMemorySize=15g -XX:-UseLargePages -XX:-UseBiasedLocking
-Djava.ext.dirs=/export/servers/jdk/jre/lib/ext:/export/servers/rocketmq-all-4.4.0-bin-release/bin/../lib
-cp
.:/export/servers/rocketmq-all-4.4.0-bin-release/bin/../conf:.:/export/servers/jdk/lib/dt.jar:/export/servers/jdk/lib/tools.jar
org.apache.rocketmq.broker.BrokerStartup -c
/export/servers/rocketmq-all-4.4.0-bin-release/conf/broker.conf
**gc log:**
2020-11-14T18:12:26.854+0800: 1376092.518: [GC pause (G1 Evacuation Pause)
(young) 1376092.518: [G1Ergonomics (CSet Construction) start choosing CSet,
_pending_cards: 2999, predicted base time: 2.68 ms, remaining time: 197.32 ms,
target pause time: 200.00 ms]
1376092.518: [G1Ergonomics (CSet Construction) add young regions to CSet,
eden: 255 regions, survivors: 1 regions, predicted young region time: 0.54 ms]
1376092.518: [G1Ergonomics (CSet Construction) finish choosing CSet, eden:
255 regions, survivors: 1 regions, old: 0 regions, predicted pause time: 3.22
ms, targetpause time: 200.00 ms]
, 0.0030716 secs]
[Parallel Time: 1.6 ms, GC Workers: 8]
[GC Worker Start (ms): Min: 1376092518.4, Avg: 1376092518.5, Max:
1376092518.7, Diff: 0.2]
[Ext Root Scanning (ms): Min: 0.4, Avg: 0.5, Max: 0.6, Diff: 0.2, Sum:
4.1]
[Update RS (ms): Min: 0.3, Avg: 0.4, Max: 0.4, Diff: 0.1, Sum: 2.9]
[Processed Buffers: Min: 5, Avg: 28.6, Max: 70, Diff: 65, Sum: 229]
[Scan RS (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.3]
[Code Root Scanning (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0,
Sum: 0.0]
[Object Copy (ms): Min: 0.5, Avg: 0.5, Max: 0.5, Diff: 0.1, Sum: 4.0]
[Termination (ms): Min: 0.0, Avg: 0.0, Max: 0.0, Diff: 0.0, Sum: 0.0]
[Termination Attempts: Min: 1, Avg: 2.4, Max: 4, Diff: 3, Sum: 19]
[GC Worker Other (ms): Min: 0.0, Avg: 0.0, Max: 0.1, Diff: 0.0, Sum:
0.3]
[GC Worker Total (ms): Min: 1.3, Avg: 1.4, Max: 1.5, Diff: 0.3, Sum:
11.6]
[GC Worker End (ms): Min: 1376092519.9, Avg: 1376092519.9, Max:
1376092520.0, Diff: 0.0]
[Code Root Fixup: 0.0 ms]
[Code Root Purge: 0.0 ms]
[Clear CT: 0.3 ms]
[Other: 1.2 ms]
[Choose CSet: 0.0 ms]
[Ref Proc: 0.5 ms]
[Ref Enq: 0.0 ms]
[Redirty Cards: 0.1 ms]
[Humongous Register: 0.0 ms]
[Humongous Reclaim: 0.0 ms]
[Free CSet: 0.2 ms]
[Eden: 4080.0M(4080.0M)->0.0B(4080.0M) Survivors: 16.0M->16.0M Heap:
4366.5M(8192.0M)->286.6M(8192.0M)]
[Times: user=0.01 sys=0.01, real=0.00 secs]
2020-11-14T18:12:26.857+0800: 1376092.521: Total time for which application
threads were stopped: 0.0041083 seconds, Stopping threads took: 0.0001050
seconds
2020-11-14T18:13:02.782+0800: 1376128.447: Total time for which application
threads were stopped: 2.9231854 seconds, Stopping threads took: 2.9224164
seconds
2020-11-14T18:13:06.486+0800: 1376132.150: Total time for which application
threads were stopped: 2.7035805 seconds, Stopping threads took: 2.7026320
seconds
2020-11-14T18:13:14.042+0800: 1376139.706: Total time for which application
threads were stopped: 6.5561192 seconds, Stopping threads took: 6.5552982
seconds
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
[email protected]