Forums

Articles
Create
cancel
Showing results for 
Search instead for 
Did you mean: 

All the time GC Allocation Failures

Tomasz Dubiel August 31, 2021

jira_java.PNG

Hello. This is the usage of RAM by Java on my Jira server. Plenty of RAM is available. 8 GB of RAM, free RAM 6 GB, RAM used - 2 GB. However, I see all the time allocation failures in Jira logs.

2021-09-01T08:38:03.148+0200: 51009.205: [GC (Allocation Failure) [PSYoungGen: 2071466K->24389K(2066432K)] 3301838K->1255115K(8357888K), 0.0756700 secs] [Times: user=0.14 sys=0.00, real=0.08 secs]
2021-09-01T08:38:27.204+0200: 51033.239: [GC (Allocation Failure) [PSYoungGen: 2065221K->21547K(2068992K)] 3295947K->1252671K(8360448K), 0.0756685 secs] [Times: user=0.15 sys=0.00, real=0.07 secs]
2021-09-01T08:38:40.282+0200: 51046.308: [GC (Allocation Failure) [PSYoungGen: 2062379K->22544K(2068992K)] 3293503K->1254392K(8360448K), 0.0699382 secs] [Times: user=0.15 sys=0.00, real=0.07 secs]
2021-09-01T08:38:58.290+0200: 51064.300: [GC (Allocation Failure) [PSYoungGen: 2063376K->21217K(2068992K)] 3295224K->1254177K(8360448K), 0.0699216 secs] [Times: user=0.14 sys=0.04, real=0.06 secs]
2021-09-01T08:39:21.889+0200: 51087.884: [GC (Allocation Failure) [PSYoungGen: 2062049K->22551K(2069504K)] 3295009K->1256084K(8360960K), 0.0839347 secs] [Times: user=0.17 sys=0.02, real=0.08 secs]
2021-09-01T08:39:33.192+0200: 51099.175: [GC (Allocation Failure) [PSYoungGen: 2064407K->21237K(2069504K)] 3297940K->1256218K(8360960K), 0.0781307 secs] [Times: user=0.15 sys=0.00, real=0.08 secs]
2021-09-01T08:39:44.029+0200: 51110.003: [GC (Allocation Failure) [PSYoungGen: 2063093K->23253K(2070016K)] 3298074K->1259246K(8361472K), 0.0635178 secs] [Times: user=0.16 sys=0.00, real=0.06 secs]
2021-09-01T08:40:04.280+0200: 51130.237: [GC (Allocation Failure) [PSYoungGen: 2066133K->19490K(2070016K)] 3302126K->1256151K(8361472K), 0.0752106 secs] [Times: user=0.16 sys=0.01, real=0.08 secs]
2021-09-01T08:40:17.420+0200: 51143.368: [GC (Allocation Failure) [PSYoungGen: 2062370K->20774K(2070528K)] 3299031K->1257788K(8361984K), 0.0600858 secs] [Times: user=0.14 sys=0.00, real=0.06 secs]
2021-09-01T08:40:29.256+0200: 51155.194: [GC (Allocation Failure) [PSYoungGen: 2064166K->22946K(2070016K)] 3301180K->1262055K(8361472K), 0.0653567 secs] [Times: user=0.17 sys=0.00, real=0.07 secs]
2021-09-01T08:40:38.598+0200: 51164.528: [GC (Allocation Failure) [PSYoungGen: 2066338K->16663K(2069504K)] 3305447K->1256298K(8360960K), 0.0960412 secs] [Times: user=0.19 sys=0.04, real=0.10 secs]
2021-09-01T08:40:53.697+0200: 51179.616: [GC (Allocation Failure) [PSYoungGen: 2059543K->23105K(2070016K)] 3299178K->1262836K(8361472K), 0.0859570 secs] [Times: user=0.14 sys=0.02, real=0.09 secs]
2021-09-01T08:41:05.113+0200: 51191.023: [GC (Allocation Failure) [PSYoungGen: 2065985K->18449K(2070016K)] 3305716K->1258365K(8361472K), 0.0762517 secs] [Times: user=0.18 sys=0.01, real=0.08 secs]
2021-09-01T08:41:13.169+0200: 51199.071: [GC (Allocation Failure) [PSYoungGen: 2061329K->23151K(2070016K)] 3301245K->1263696K(8361472K), 0.0815816 secs] [Times: user=0.15 sys=0.00, real=0.08 secs]
2021-09-01T08:41:22.953+0200: 51208.847: [GC (GCLocker Initiated GC) [PSYoungGen: 2066031K->20116K(2070528K)] 3306579K->1264313K(8361984K), 0.0631541 secs] [Times: user=0.13 sys=0.02, real=0.07 secs]
2021-09-01T08:41:34.448+0200: 51220.335: [GC (Allocation Failure) [PSYoungGen: 2063508K->15170K(2070016K)] 3307706K->1259550K(8361472K), 0.0779939 secs] [Times: user=0.15 sys=0.00, real=0.08 secs]

 

What is the reason of these errors? We use JIRA Service Desk 3.16.11, Jira Software 7.13.11 and Jira Core 7.13.11.

2 answers

0 votes
Daniel Ebers
Rising Star
Rising Star
Rising Stars are recognized for providing high-quality answers to other users. Rising Stars receive a certificate of achievement and are on the path to becoming Community Leaders.
September 5, 2021

Hi @Tomasz Dubiel

first of all the sad news that debugging something like you are seeing is pretty hard from the outside - without knowing the system in-depth and without having access to it's console.

That being said and adding to the great information you have already received two things come to mind:

1.) The version of Jira (7.13) is rather old and meanwhile unsupported. Upgrading, if possible, to a more recent version could lead to improved performance and a better experience (for users but also for admins)

2.) I seem to recognize that you are not using the g1gc garbage collector. You could double check in your configuration file "setenv.sh":

While I do not want to say this is the golden key for whatever - we saw in the past a better management of memory when switching to that garbage collector.

You can read more about it here:

Please note the prepending sentence which might lead into a solution (but that is no guarantee!):

In many circumstances, we now recommend the Garbage First Garbage Collector (G1GC).

Please test it, if possible, on a test environment first. Currently I do not recall if this recommendation was all valid for 7.13 versions already - for a 8.x version it is confirmedly a good advise.

Regards,
Daniel

0 votes
Mirek
Community Leader
Community Leader
Community Leaders are connectors, ambassadors, and mentors. On the online community, they serve as thought leaders, product experts, and moderators.
September 1, 2021

Hi @Tomasz Dubiel ,

Allocation errors might be caused by few things but it requires a little bit more information what is exactly going on at that specific moment, which threads are working and how the server memory is used (not only Jira memory). Thanks to that you can tweak your memory settings to be sure that everything is working fine.

I remember @Andy Heinzer investigated and explained pretty well on a similar topic

https://community.atlassian.com/t5/Jira-Software-questions/Garbage-Collector-Alllocation-Failure/qaq-p/1322269

I recommend to read everything and check whatever Andy is suggesting.

You might be also hitting some of those problems

https://confluence.atlassian.com/jirakb/jira-running-out-of-memory-due-to-gc-allocation-race-condition-957122851.html

https://confluence.atlassian.com/jirakb/jira-becomes-unresponsive-occasionally-and-logs-several-full-gc-events-1014679965.html

However your pause time does not seem to be long, so I guess application if fully responsive on those moments.

Tomasz Dubiel September 1, 2021

Yeah, application runs smoothly, we don't experience any problems, but these errors are just spamming in log.

Should we try to give Jira minimum and maximum RAM usage at 4GB and increase RAM on server to 16 GB? The total RAM on server is now 11,5 GB. I've read in topic
"We always expect the system to have about 4x the system memory as the heap Jira will use"

Tomasz Dubiel September 1, 2021

Although, indeed, for some users Jira becomes unresponsive.

Mirek
Community Leader
Community Leader
Community Leaders are connectors, ambassadors, and mentors. On the online community, they serve as thought leaders, product experts, and moderators.
September 1, 2021

Yes system should be also having enough memory to run smoothly. Check also your Xmx and Xms parameters. It is nice to have them on the same value.

Tomasz Dubiel September 1, 2021

We will increase today RAM on server to 16 GB and change the values of Xmx and Xms to 4 GB and will see if it helps.

Like • Mirek likes this
Tomasz Dubiel September 1, 2021

Nothing is better. After changes there is still plenty of gc allocation failures and performance of Jira decreased.

Java HotSpot(TM) 64-Bit Server VM (25.181-b13) for linux-amd64 JRE (1.8.0_181-b13), built on Jul 7 2018 00:56:38 by "java_re" with gcc 4.3.0 20080428 (Red Hat 4.3.0-8)
Memory: 4k page, physical 16040860k(15657980k free), swap 8191996k(8191996k free)
CommandLine flags: -XX:GCLogFileSize=20971520 -XX:InitialCodeCacheSize=33554432 -XX:InitialHeapSize=4294967296 -XX:MaxHeapSize=4294967296 -XX:NumberOfGCLogFiles=5 -XX:-OmitStackTraceInFastThrow -XX:+PrintGC -XX:+PrintGCCause -XX:+PrintGC
DateStamps -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -XX:ReservedCodeCacheSize=536870912 -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseGCLogFileRotation -XX:+UseParallelGC
2021-09-01T18:04:34.449+0200: 11.354: [GC (Allocation Failure) [PSYoungGen: 1048576K->44062K(1223168K)] 1048576K->44150K(4019712K), 0.1167455 secs] [Times: user=0.22 sys=0.02, real=0.11 secs]
2021-09-01T18:04:35.400+0200: 12.305: [GC (Metadata GC Threshold) [PSYoungGen: 346471K->29231K(1223168K)] 346559K->29327K(4019712K), 0.0370215 secs] [Times: user=0.12 sys=0.01, real=0.04 secs]
2021-09-01T18:04:35.437+0200: 12.342: [Full GC (Metadata GC Threshold) [PSYoungGen: 29231K->0K(1223168K)] [ParOldGen: 96K->28332K(2796544K)] 29327K->28332K(4019712K), [Metaspace: 20775K->20775K(1069056K)], 0.1000532 secs] [Times: user=0.
26 sys=0.02, real=0.10 secs]
2021-09-01T18:04:37.300+0200: 14.209: [GC (Metadata GC Threshold) [PSYoungGen: 503140K->18649K(1223168K)] 531472K->46989K(4019712K), 0.0130637 secs] [Times: user=0.05 sys=0.00, real=0.02 secs]
2021-09-01T18:04:37.313+0200: 14.222: [Full GC (Metadata GC Threshold) [PSYoungGen: 18649K->0K(1223168K)] [ParOldGen: 28340K->37880K(2796544K)] 46989K->37880K(4019712K), [Metaspace: 34593K->34552K(1081344K)], 0.0715049 secs] [Times: user
=0.23 sys=0.01, real=0.06 secs]
2021-09-01T18:04:46.828+0200: 23.745: [GC (System.gc()) [PSYoungGen: 141570K->579K(1223168K)] 179450K->38467K(4019712K), 0.0023262 secs] [Times: user=0.01 sys=0.00, real=0.00 secs]
2021-09-01T18:04:46.830+0200: 23.747: [Full GC (System.gc()) [PSYoungGen: 579K->0K(1223168K)] [ParOldGen: 37888K->28975K(2796544K)] 38467K->28975K(4019712K), [Metaspace: 35464K->35464K(1081344K)], 0.1609158 secs] [Times: user=0.76 sys=0.
01, real=0.16 secs]
2021-09-01T18:04:51.207+0200: 28.125: [GC (Metadata GC Threshold) [PSYoungGen: 849535K->30193K(1223168K)] 878511K->59196K(4019712K), 0.0234082 secs] [Times: user=0.08 sys=0.00, real=0.02 secs]
2021-09-01T18:04:51.231+0200: 28.148: [Full GC (Metadata GC Threshold) [PSYoungGen: 30193K->0K(1223168K)] [ParOldGen: 29002K->57773K(2796544K)] 59196K->57773K(4019712K), [Metaspace: 59623K->59623K(1101824K)], 0.1621523 secs] [Times: user
=0.70 sys=0.02, real=0.16 secs]
2021-09-01T18:04:56.374+0200: 33.296: [GC (Allocation Failure) [PSYoungGen: 1048576K->42230K(1338880K)] 1106349K->100011K(4135424K), 0.0405149 secs] [Times: user=0.13 sys=0.00, real=0.04 secs]
2021-09-01T18:04:58.975+0200: 35.901: [GC (Allocation Failure) [PSYoungGen: 1206518K->58870K(1223168K)] 1264299K->121916K(4019712K), 0.0511231 secs] [Times: user=0.18 sys=0.05, real=0.05 secs]
2021-09-01T18:05:04.283+0200: 41.214: [GC (Allocation Failure) [PSYoungGen: 1223158K->72697K(1282048K)] 1286204K->155748K(4078592K), 0.0587197 secs] [Times: user=0.22 sys=0.05, real=0.06 secs]
2021-09-01T18:05:05.787+0200: 42.718: [GC (GCLocker Initiated GC) [PSYoungGen: 609312K->94203K(1303552K)] 692362K->197093K(4100096K), 0.0677083 secs] [Times: user=0.28 sys=0.03, real=0.07 secs]
2021-09-01T18:05:05.871+0200: 42.802: [GC (Metadata GC Threshold) [PSYoungGen: 99341K->87940K(1240064K)] 202231K->190839K(4036608K), 0.0530940 secs] [Times: user=0.31 sys=0.00, real=0.05 secs]
2021-09-01T18:05:05.924+0200: 42.856: [Full GC (Metadata GC Threshold) [PSYoungGen: 87940K->0K(1240064K)] [ParOldGen: 102898K->136024K(2796544K)] 190839K->136024K(4036608K), [Metaspace: 96515K->96500K(1138688K)], 0.2576647 secs] [Times:
user=1.22 sys=0.04, real=0.25 secs]
2021-09-01T18:05:08.407+0200: 45.343: [GC (Allocation Failure) [PSYoungGen: 1145856K->69625K(1271808K)] 1281880K->205657K(4068352K), 0.0351966 secs] [Times: user=0.18 sys=0.00, real=0.03 secs]
2021-09-01T18:05:09.471+0200: 46.407: [GC (Allocation Failure) [PSYoungGen: 1215481K->64609K(1275392K)] 1351513K->200649K(4071936K), 0.0440511 secs] [Times: user=0.24 sys=0.00, real=0.04 secs]
2021-09-01T18:05:11.789+0200: 48.730: [GC (Allocation Failure) [PSYoungGen: 1214561K->92080K(1242112K)] 1350601K->247153K(4038656K), 0.0787085 secs] [Times: user=0.48 sys=0.00, real=0.08 secs]
2021-09-01T18:05:15.546+0200: 52.488: [GC (Metadata GC Threshold) [PSYoungGen: 972047K->40371K(1272320K)] 1127120K->252783K(4068864K), 0.0674863 secs] [Times: user=0.28 sys=0.03, real=0.07 secs]
2021-09-01T18:05:15.614+0200: 52.555: [Full GC (Metadata GC Threshold) [PSYoungGen: 40371K->0K(1272320K)] [ParOldGen: 212412K->233542K(2796544K)] 252783K->233542K(4068864K), [Metaspace: 154333K->154333K(1196032K)], 0.5280595 secs] [Times
: user=2.75 sys=0.04, real=0.53 secs]
2021-09-01T18:05:18.870+0200: 55.816: [GC (Allocation Failure) [PSYoungGen: 1143296K->54206K(1268736K)] 1376838K->287756K(4065280K), 0.0374593 secs] [Times: user=0.19 sys=0.00, real=0.03 secs]
2021-09-01T18:05:22.178+0200: 59.130: [GC (Allocation Failure) [PSYoungGen: 1197502K->51807K(1284096K)] 1431052K->322600K(4080640K), 0.0707568 secs] [Times: user=0.44 sys=0.01, real=0.07 secs]
2021-09-01T18:05:26.657+0200: 63.609: [GC (Allocation Failure) [PSYoungGen: 1217119K->24649K(1278976K)] 1487912K->335382K(4075520K), 0.0528019 secs] [Times: user=0.22 sys=0.03, real=0.05 secs]
2021-09-01T18:05:31.408+0200: 68.365: [GC (Allocation Failure) [PSYoungGen: 1189961K->35688K(1287680K)] 1500694K->367125K(4084224K), 0.0449136 secs] [Times: user=0.22 sys=0.02, real=0.04 secs]
2021-09-01T18:05:36.373+0200: 73.336: [GC (Allocation Failure) [PSYoungGen: 1210216K->31753K(1284608K)] 1541653K->390727K(4081152K), 0.0492922 secs] [Times: user=0.20 sys=0.02, real=0.05 secs]
2021-09-01T18:05:43.618+0200: 80.594: [GC (Allocation Failure) [PSYoungGen: 1206281K->76359K(1282048K)] 1565255K->435341K(4078592K), 0.0505049 secs] [Times: user=0.23 sys=0.01, real=0.06 secs]
2021-09-01T18:05:47.835+0200: 84.816: [GC (Allocation Failure) [PSYoungGen: 1250887K->90556K(1265152K)] 1609869K->449546K(4061696K), 0.0496187 secs] [Times: user=0.21 sys=0.00, real=0.05 secs]
2021-09-01T18:05:52.478+0200: 89.466: [GC (Allocation Failure) [PSYoungGen: 1265084K->119795K(1192960K)] 1624074K->546856K(3989504K), 0.1021122 secs] [Times: user=0.38 sys=0.04, real=0.10 secs]
2021-09-01T18:05:53.607+0200: 90.595: [GC (Allocation Failure) [PSYoungGen: 1192947K->113067K(1186304K)] 1620008K->575616K(3982848K), 0.0956062 secs] [Times: user=0.41 sys=0.02, real=0.09 secs]
2021-09-01T18:05:54.267+0200: 91.254: [GC (GCLocker Initiated GC) [PSYoungGen: 1186219K->52947K(1234432K)] 1650294K->589089K(4030976K), 0.0866960 secs] [Times: user=0.48 sys=0.03, real=0.08 secs]
2021-09-01T18:05:54.907+0200: 91.895: [GC (Allocation Failure) [PSYoungGen: 1117907K->33238K(1228288K)] 1654067K->615446K(4024832K), 0.0631250 secs] [Times: user=0.36 sys=0.01, real=0.06 secs]
2021-09-01T18:05:56.673+0200: 93.661: [GC (Allocation Failure) [PSYoungGen: 1098198K->84491K(1240064K)] 1680406K->688171K(4036608K), 0.0578765 secs] [Times: user=0.29 sys=0.03, real=0.06 secs]
2021-09-01T18:06:00.515+0200: 97.509: [GC (Allocation Failure) [PSYoungGen: 1163787K->61466K(1236992K)] 1767467K->711771K(4033536K), 0.1088409 secs] [Times: user=0.55 sys=0.02, real=0.11 secs]
2021-09-01T18:06:00.764+0200: 97.758: [GC (Metadata GC Threshold) [PSYoungGen: 171366K->8193K(1243648K)] 821671K->699681K(4040192K), 0.0929229 secs] [Times: user=0.29 sys=0.03, real=0.09 secs]
2021-09-01T18:06:00.858+0200: 97.851: [Full GC (Metadata GC Threshold) [PSYoungGen: 8193K->0K(1243648K)] [ParOldGen: 691488K->607763K(2796544K)] 699681K->607763K(4040192K), [Metaspace: 260526K->260399K(1292288K)], 1.5589945 secs] [Times:
user=6.61 sys=0.12, real=1.56 secs]
2021-09-01T18:06:43.861+0200: 140.910: [GC (Allocation Failure) [PSYoungGen: 1093304K->63745K(1245696K)] 1701068K->671516K(4042240K), 0.0790145 secs] [Times: user=0.19 sys=0.00, real=0.08 secs]
2021-09-01T18:07:38.702+0200: 195.820: [GC (Allocation Failure) [PSYoungGen: 1157377K->15161K(1253888K)] 1765148K->666205K(4050432K), 0.0897002 secs] [Times: user=0.24 sys=0.01, real=0.09 secs]
2021-09-01T18:11:24.185+0200: 421.592: [GC (Allocation Failure) [PSYoungGen: 1125177K->50517K(1253888K)] 1776221K->712071K(4050432K), 0.0967792 secs] [Times: user=0.34 sys=0.00, real=0.10 secs]
2021-09-01T18:11:28.157+0200: 425.570: [GC (Allocation Failure) [PSYoungGen: 1160533K->10696K(1261568K)] 1822087K->710468K(4058112K), 0.0988923 secs] [Times: user=0.44 sys=0.01, real=0.10 secs]
2021-09-01T18:11:51.344+0200: 448.785: [GC (Allocation Failure) [PSYoungGen: 1136072K->7571K(1261568K)] 1835844K->708050K(4058112K), 0.0744260 secs] [Times: user=0.21 sys=0.00, real=0.07 secs]
2021-09-01T18:12:02.411+0200: 459.871: [GC (Allocation Failure) [PSYoungGen: 1132947K->18348K(1265664K)] 1833426K->721230K(4062208K), 0.0900114 secs] [Times: user=0.25 sys=0.00, real=0.09 secs]
2021-09-01T18:12:04.801+0200: 462.261: [GC (Allocation Failure) [PSYoungGen: 1148332K->6097K(1262080K)] 1851214K->721911K(4058624K), 0.0735031 secs] [Times: user=0.15 sys=0.00, real=0.08 secs]
2021-09-01T18:12:08.185+0200: 465.653: [GC (Allocation Failure) [PSYoungGen: 1136081K->17290K(1272832K)] 1851895K->733231K(4069376K), 0.0651290 secs] [Times: user=0.21 sys=0.00, real=0.07 secs]
2021-09-01T18:12:24.554+0200: 482.041: [GC (Allocation Failure) [PSYoungGen: 1160074K->18685K(1267712K)] 1876015K->734635K(4064256K), 0.0558116 secs] [Times: user=0.13 sys=0.00, real=0.06 secs]
2021-09-01T18:12:56.461+0200: 513.989: [GC (Allocation Failure) [PSYoungGen: 1161469K->42369K(1284096K)] 1877419K->758326K(4080640K), 0.0764578 secs] [Times: user=0.15 sys=0.00, real=0.08 secs]
2021-09-01T18:13:03.876+0200: 521.417: [GC (Allocation Failure) [PSYoungGen: 1206657K->36064K(1277952K)] 1922614K->752030K(4074496K), 0.0740016 secs] [Times: user=0.16 sys=0.00, real=0.07 secs]
2021-09-01T18:13:30.098+0200: 547.674: [GC (Allocation Failure) [PSYoungGen: 1200352K->61316K(1287168K)] 1916318K->777289K(4083712K), 0.0974724 secs] [Times: user=0.25 sys=0.00, real=0.10 secs]

Tomasz Dubiel September 1, 2021

Nothing is better. After changes there is still plenty of gc allocation failures and performance of Jira dropped.

I changed back min and max RAM to 6 GB and performance is better, but there is still plenty of GC allocation failures.

Java HotSpot(TM) 64-Bit Server VM (25.181-b13) for linux-amd64 JRE (1.8.0_181-b13), built on Jul 7 2018 00:56:38 by "java_re" with gcc 4.3.0 20080428 (Red Hat 4.3.0-8)
Memory: 4k page, physical 16040860k(3344632k free), swap 8191996k(8191996k free)
CommandLine flags: -XX:GCLogFileSize=20971520 -XX:InitialCodeCacheSize=33554432 -XX:InitialHeapSize=6442450944 -XX:MaxHeapSize=6442450944 -XX:NumberOfGCLogFiles=5 -XX:-OmitStackTraceInFastThrow -XX:+PrintGC -XX:+PrintGCCause -XX:+PrintGC
DateStamps -XX:+PrintGCDetails -XX:+PrintGCTimeStamps -XX:ReservedCodeCacheSize=536870912 -XX:+UseCompressedClassPointers -XX:+UseCompressedOops -XX:+UseGCLogFileRotation -XX:+UseParallelGC
2021-09-01T18:40:50.546+0200: 11.265: [GC (Metadata GC Threshold) [PSYoungGen: 1352673K->51529K(1835008K)] 1352673K->51689K(6029312K), 0.0969471 secs] [Times: user=0.20 sys=0.04, real=0.10 secs]
2021-09-01T18:40:50.643+0200: 11.362: [Full GC (Metadata GC Threshold) [PSYoungGen: 51529K->0K(1835008K)] [ParOldGen: 160K->49897K(4194304K)] 51689K->49897K(6029312K), [Metaspace: 20752K->20752K(1069056K)], 0.1033020 secs] [Times: user=0
.30 sys=0.04, real=0.10 secs]
2021-09-01T18:41:01.300+0200: 22.038: [GC (System.gc()) [PSYoungGen: 581997K->15309K(1835008K)] 631895K->65215K(6029312K), 0.0232392 secs] [Times: user=0.02 sys=0.02, real=0.03 secs]
2021-09-01T18:41:01.323+0200: 22.061: [Full GC (System.gc()) [PSYoungGen: 15309K->0K(1835008K)] [ParOldGen: 49905K->34133K(4194304K)] 65215K->34133K(6029312K), [Metaspace: 32084K->32084K(1079296K)], 0.1359545 secs] [Times: user=0.55 sys=
0.02, real=0.13 secs]
2021-09-01T18:41:04.691+0200: 25.439: [GC (Metadata GC Threshold) [PSYoungGen: 833634K->25096K(1835008K)] 867767K->59257K(6029312K), 0.0292944 secs] [Times: user=0.08 sys=0.00, real=0.03 secs]
2021-09-01T18:41:04.721+0200: 25.468: [Full GC (Metadata GC Threshold) [PSYoungGen: 25096K->0K(1835008K)] [ParOldGen: 34160K->51868K(4194304K)] 59257K->51868K(6029312K), [Metaspace: 54000K->54000K(1097728K)], 0.1653519 secs] [Times: user
=0.72 sys=0.01, real=0.16 secs]
2021-09-01T18:41:11.818+0200: 32.585: [GC (Allocation Failure) [PSYoungGen: 1572864K->66307K(1835008K)] 1624732K->118183K(6029312K), 0.0743139 secs] [Times: user=0.15 sys=0.04, real=0.08 secs]
2021-09-01T18:41:16.998+0200: 37.774: [GC (Allocation Failure) [PSYoungGen: 1639171K->77475K(1835008K)] 1691047K->129359K(6029312K), 0.0710071 secs] [Times: user=0.23 sys=0.00, real=0.07 secs]
2021-09-01T18:41:19.723+0200: 40.499: [GC (GCLocker Initiated GC) [PSYoungGen: 802695K->114756K(1971200K)] 854580K->166657K(6165504K), 0.0778236 secs] [Times: user=0.40 sys=0.04, real=0.07 secs]
2021-09-01T18:41:19.816+0200: 40.592: [GC (Metadata GC Threshold) [PSYoungGen: 165812K->87847K(1835008K)] 217713K->139755K(6029312K), 0.0604844 secs] [Times: user=0.37 sys=0.05, real=0.06 secs]
2021-09-01T18:41:19.876+0200: 40.653: [Full GC (Metadata GC Threshold) [PSYoungGen: 87847K->0K(1835008K)] [ParOldGen: 51908K->129604K(4194304K)] 139755K->129604K(6029312K), [Metaspace: 87324K->87311K(1130496K)], 0.3028767 secs] [Times: u
ser=1.65 sys=0.06, real=0.30 secs]
2021-09-01T18:41:23.356+0200: 44.142: [GC (Allocation Failure) [PSYoungGen: 1709056K->98821K(1950208K)] 1838660K->228434K(6144512K), 0.0954142 secs] [Times: user=0.30 sys=0.05, real=0.09 secs]
2021-09-01T18:41:26.235+0200: 47.021: [GC (Allocation Failure) [PSYoungGen: 1917445K->124553K(1943552K)] 2047058K->254174K(6137856K), 0.0638217 secs] [Times: user=0.35 sys=0.03, real=0.06 secs]
2021-09-01T18:41:27.347+0200: 48.143: [GC (Metadata GC Threshold) [PSYoungGen: 725227K->99445K(1937408K)] 854848K->229074K(6131712K), 0.0602953 secs] [Times: user=0.29 sys=0.01, real=0.06 secs]
2021-09-01T18:41:27.408+0200: 48.203: [Full GC (Metadata GC Threshold) [PSYoungGen: 99445K->0K(1937408K)] [ParOldGen: 129628K->211509K(4194304K)] 229074K->211509K(6131712K), [Metaspace: 140131K->140127K(1181696K)], 0.4910337 secs] [Times
: user=2.52 sys=0.14, real=0.49 secs]
2021-09-01T18:41:32.679+0200: 53.485: [GC (Allocation Failure) [PSYoungGen: 1783808K->86047K(1940480K)] 1995317K->297564K(6134784K), 0.0541794 secs] [Times: user=0.29 sys=0.01, real=0.06 secs]
2021-09-01T18:41:38.445+0200: 59.260: [GC (Allocation Failure) [PSYoungGen: 1869855K->116307K(1930752K)] 2081372K->327832K(6125056K), 0.0733396 secs] [Times: user=0.42 sys=0.00, real=0.07 secs]
2021-09-01T18:41:45.442+0200: 66.267: [GC (Allocation Failure) [PSYoungGen: 1894995K->94701K(1937920K)] 2106520K->358872K(6132224K), 0.0860741 secs] [Times: user=0.46 sys=0.03, real=0.08 secs]
2021-09-01T18:41:55.865+0200: 76.709: [GC (Allocation Failure) [PSYoungGen: 1873389K->77788K(1947136K)] 2137560K->425431K(6141440K), 0.0944022 secs] [Times: user=0.56 sys=0.06, real=0.09 secs]
2021-09-01T18:42:03.870+0200: 84.733: [GC (Allocation Failure) [PSYoungGen: 1868252K->47980K(1940480K)] 2215895K->442900K(6134784K), 0.0605011 secs] [Times: user=0.21 sys=0.04, real=0.06 secs]
2021-09-01T18:42:05.204+0200: 86.067: [GC (Metadata GC Threshold) [PSYoungGen: 397567K->27939K(1945088K)] 792487K->453223K(6139392K), 0.0474688 secs] [Times: user=0.23 sys=0.03, real=0.04 secs]
2021-09-01T18:42:05.252+0200: 86.114: [Full GC (Metadata GC Threshold) [PSYoungGen: 27939K->0K(1945088K)] [ParOldGen: 425284K->410166K(4194304K)] 453223K->410166K(6139392K), [Metaspace: 235424K->235419K(1269760K)], 0.8947080 secs] [Times
: user=4.45 sys=0.12, real=0.90 secs]
2021-09-01T18:42:09.286+0200: 90.158: [GC (Allocation Failure) [PSYoungGen: 1796096K->125126K(1921536K)] 2206262K->535301K(6115840K), 0.0720252 secs] [Times: user=0.29 sys=0.00, real=0.07 secs]
2021-09-01T18:42:10.379+0200: 91.251: [GC (Allocation Failure) [PSYoungGen: 1921222K->45764K(1937920K)] 2331397K->531041K(6132224K), 0.1010073 secs] [Times: user=0.60 sys=0.05, real=0.10 secs]
2021-09-01T18:42:12.729+0200: 93.611: [GC (Allocation Failure) [PSYoungGen: 1821892K->141861K(1918464K)] 2307169K->663413K(6112768K), 0.0971709 secs] [Times: user=0.51 sys=0.02, real=0.10 secs]
2021-09-01T18:42:25.557+0200: 106.459: [GC (Allocation Failure) [PSYoungGen: 1917989K->100898K(1924096K)] 2439541K->693710K(6118400K), 0.1604170 secs] [Times: user=0.56 sys=0.06, real=0.16 secs]
2021-09-01T18:42:35.405+0200: 116.326: [GC (Allocation Failure) [PSYoungGen: 1849378K->50264K(1921536K)] 2442190K->706352K(6115840K), 0.1434299 secs] [Times: user=0.42 sys=0.05, real=0.15 secs]
2021-09-01T18:43:42.251+0200: 183.308: [GC (Allocation Failure) [PSYoungGen: 1798744K->20220K(1925120K)] 2454832K->702378K(6119424K), 0.0903627 secs] [Times: user=0.22 sys=0.03, real=0.08 secs]
2021-09-01T18:44:02.426+0200: 203.522: [GC (Allocation Failure) [PSYoungGen: 1775356K->97698K(1926144K)] 2457514K->779864K(6120448K), 0.1350305 secs] [Times: user=0.36 sys=0.00, real=0.13 secs]
2021-09-01T18:44:12.485+0200: 213.601: [GC (Allocation Failure) [PSYoungGen: 1852834K->145218K(1894400K)] 2535000K->827391K(6088704K), 0.1431945 secs] [Times: user=0.40 sys=0.01, real=0.14 secs]

Tomasz Dubiel September 1, 2021 edited

Usunięte

Tomasz Dubiel September 3, 2021

Do you have any other idea?

Suggest an answer

Log in or Sign up to answer