記一次Metaspace導(dǎo)致頻繁fgc的問(wèn)題排查過(guò)程

最近線上有一條機(jī)器在運(yùn)行了10幾天后出現(xiàn)告警,頻繁出現(xiàn)fgc券册,在切斷流量之后蚣常,從運(yùn)維那邊拿了應(yīng)用的heapdump文件市咽。
在一開(kāi)始出現(xiàn)fgc時(shí),我就上了容器平臺(tái)查看了gc日志史隆,gc日志如下:


image.png

從日志中可以看出很明顯優(yōu)于metaspace空間不夠造成的fgc魂务,而且不斷進(jìn)行fgc,且metaspace空間回收不了泌射。于是查看一下jvm啟動(dòng)參數(shù)粘姜,參數(shù)如下:


image.png

這里Metaspace和MaxMetaspace都設(shè)置成了256M,奇怪了gc日志中Metaspace才使用了165M就出現(xiàn)了fgc熔酷,難道是新加載的類90M的空間嗎孤紧,這個(gè)可以肯定不是,如果不是新申請(qǐng)90M的空間這個(gè)原因引起的拒秘,那么就只有metaspace內(nèi)存碎片引起的了号显。于是通過(guò)mat分析heapdump臭猜,發(fā)現(xiàn)DelegatingClassLoader有1100多個(gè),于是先查看一下DelegatingClassLoader是個(gè)什么東西押蚤?其屬于sun.reflect包下蔑歌,代碼如下:

classDelegatingClassLoader extendsClassLoader {
    DelegatingClassLoader(ClassLoader var1) {
        super(var1);
    }

證明其確實(shí)一個(gè)ClassLoader。

那到底是什么對(duì)象在引用這些ClassLoader呢揽碘,通過(guò)mat發(fā)現(xiàn)是GeneratedMethodAccessor在引用這些ClassLoader次屠,繼續(xù)跟蹤發(fā)現(xiàn)是mybatis的Reflector應(yīng)用了這些對(duì)象。好辦了雳刺,于是繼續(xù)查看了Reflector的代碼劫灶,代碼片段如下:

privateMap<String, Invoker> setMethods= newHashMap<String, Invoker>();
privateMap<String, Invoker> getMethods= newHashMap<String, Invoker>();
privateMap<String, Class<?>> setTypes= newHashMap<String, Class<?>>();
privateMap<String, Class<?>> getTypes= newHashMap<String, Class<?>>();

這個(gè)Reflector對(duì)象會(huì)緩存orm中實(shí)體類的getter setter方法,mybatis需要將表中的記錄轉(zhuǎn)換成java實(shí)體類掖桦,為了提高反射的效率將實(shí)體類的方法本昏、構(gòu)造函數(shù)等緩存起來(lái)了,Mybatis會(huì)在運(yùn)行的過(guò)程中通過(guò)ReflectorFactory為每一個(gè)實(shí)體類創(chuàng)建一個(gè)Reflector方便后續(xù)進(jìn)行反射調(diào)用枪汪。
問(wèn)題來(lái)了涌穆,為什么會(huì)有這么多的DelegatingClassLoader呢?通過(guò)mat可以分析出來(lái)雀久,這些ClassLoader最終都是被java的Method對(duì)象所引用的蒲犬。
于是分析Method的創(chuàng)建過(guò)程和Method的調(diào)用過(guò)程,最終發(fā)現(xiàn)Method在調(diào)用過(guò)程會(huì)創(chuàng)建一個(gè)MethodAccessor并將MehtodAccessor作為存在一個(gè)叫做methodAccessor的field中岸啡,java為了提高反射調(diào)用的性能,用了一種膨脹(inflation)的方式(從jni調(diào)用轉(zhuǎn)換成classbytes調(diào)用)赫编,通過(guò)參數(shù)-Dsun.reflect.inflationThreshold進(jìn)行控制默認(rèn)15巡蘸,在小于這個(gè)次數(shù)時(shí)會(huì)使用native的方式對(duì)方法進(jìn)行調(diào)用,如果method的調(diào)用次數(shù)超過(guò)指定次數(shù)就會(huì)使用字節(jié)碼的方式生成方法調(diào)用擂送,如果使用字節(jié)碼的方式最終會(huì)為每一個(gè)方法都生成DelegatingClassLoader悦荒。
具體的源碼如下:
Method.invoke方法:

image.png

Method.acquireMethodAccessor方法:


image.png

ReflectionFactory.newMethodAccessor方法:


image.png

NativeMethodAccessorImpl.invoke方法:

publicObject invoke(Object var1, Object[] var2) throwsIllegalArgumentException, InvocationTargetException {
    if(++this.numInvocations > ReflectionFactory.inflationThreshold() && !ReflectUtil.isVMAnonymousClass(this.method.getDeclaringClass())) {
        MethodAccessorImpl var3 = (MethodAccessorImpl)(newMethodAccessorGenerator()).generateMethod(this.method.getDeclaringClass(), this.method.getName(), this.method.getParameterTypes(), this.method.getReturnType(), this.method.getExceptionTypes(), this.method.getModifiers());
        this.parent.setDelegate(var3);
    }

    returninvoke0(this.method, var1, var2);
}

MethodAccessorGenerator.generateMethod方法片段:

image.png

ClassDefiner.defineClass方法:

image.png

另外還有RefectionFactory的checkInitted方法會(huì)通過(guò)System.getProperty方法拿sun.reflect.inflationThresholdproperty,默認(rèn)值為15嘹吨。
代碼的流程不是很長(zhǎng)搬味,切比較容易理解。接下來(lái)就是驗(yàn)證是不是java反射的Inflat方式引起的蟀拷。于是寫了下面的例子進(jìn)行驗(yàn)證:

/
-XX:MetaspaceSize=64M -XX:MaxMetaspaceSize=64M -Xms1g -Xmx1g -XX:+UseConcMarkSweepGC
 -XX:CMSInitiatingOccupancyFraction=75  -XX:+UseCMSInitiatingOccupancyOnly -XX:+PrintGCTimeStamps
-XX:+PrintGCDetails -Dsun.reflect.inflationThreshold=0
/

public static voidmain(String[] args) throwsIOException, InvocationTargetException, IllegalAccessException {
    ReflectorFactory reflectorFactory = newDefaultReflectorFactory();
    System.out.println("load class start");
    // model有1000個(gè)方法
Reflector reflector1 = reflectorFactory.findForClass(TestModel.class);
    Reflector reflector2 = reflectorFactory.findForClass(TestModel2.class);
    Reflector reflector3 = reflectorFactory.findForClass(TestModel3.class);

    System.out.println("load class finished");
    
    // model有1000個(gè)方法
TestModel testModel = newTestModel();

    Object[] empty = {};
    Object[] one1 = {"a"};

    TestModel2 testModel2 = newTestModel2();

    TestModel3 testModel3 = newTestModel3();

    System.out.println("method invoke start");
    for(inti = 0; i < 1; i++) {
        for(intj = 0; j < 1000; j++) {
            reflector1.getSetInvoker("field"+ j).invoke(testModel, one1);
            reflector1.getGetInvoker("field"+ j).invoke(testModel, empty);

            reflector2.getSetInvoker("field"+ j).invoke(testModel2, one1);
            reflector2.getGetInvoker("field"+ j).invoke(testModel2, empty);

            reflector3.getSetInvoker("field"+ j).invoke(testModel3, one1);
            reflector3.getGetInvoker("field"+ j).invoke(testModel3, empty);
        }
    }
    System.out.println("method invoke finished");
    System.in.read();
}

通過(guò)不設(shè)置參數(shù)sun.reflect.inflationThreshold和設(shè)置參數(shù)為0碰纬,運(yùn)行結(jié)果如下:
不設(shè)置的情況:

image.png

設(shè)置為0的情況:


image.png

可以看出兩種設(shè)置下Metaspace內(nèi)存占用相差很大,基本驗(yàn)證分析的結(jié)果是正確的问芬。
最終針對(duì)這次因?yàn)镸etaspace引起頻繁fgc的修復(fù)的方案可以有:

  • 增大Metaspace空間
  • 犧牲一些性能悦析,應(yīng)用啟動(dòng)參數(shù)中添加參數(shù)-Dsun.reflect.inflationThreshold,并將其值設(shè)置的足夠大此衅。
最后編輯于
?著作權(quán)歸作者所有,轉(zhuǎn)載或內(nèi)容合作請(qǐng)聯(lián)系作者
  • 序言:七十年代末强戴,一起剝皮案震驚了整個(gè)濱河市亭螟,隨后出現(xiàn)的幾起案子,更是在濱河造成了極大的恐慌骑歹,老刑警劉巖预烙,帶你破解...
    沈念sama閱讀 206,311評(píng)論 6 481
  • 序言:濱河連續(xù)發(fā)生了三起死亡事件,死亡現(xiàn)場(chǎng)離奇詭異道媚,居然都是意外死亡扁掸,警方通過(guò)查閱死者的電腦和手機(jī),發(fā)現(xiàn)死者居然都...
    沈念sama閱讀 88,339評(píng)論 2 382
  • 文/潘曉璐 我一進(jìn)店門衰琐,熙熙樓的掌柜王于貴愁眉苦臉地迎上來(lái)也糊,“玉大人,你說(shuō)我怎么就攤上這事羡宙±晏辏” “怎么了?”我有些...
    開(kāi)封第一講書人閱讀 152,671評(píng)論 0 342
  • 文/不壞的土叔 我叫張陵狗热,是天一觀的道長(zhǎng)钞馁。 經(jīng)常有香客問(wèn)我,道長(zhǎng)匿刮,這世上最難降的妖魔是什么僧凰? 我笑而不...
    開(kāi)封第一講書人閱讀 55,252評(píng)論 1 279
  • 正文 為了忘掉前任,我火速辦了婚禮熟丸,結(jié)果婚禮上训措,老公的妹妹穿的比我還像新娘。我一直安慰自己光羞,他們只是感情好绩鸣,可當(dāng)我...
    茶點(diǎn)故事閱讀 64,253評(píng)論 5 371
  • 文/花漫 我一把揭開(kāi)白布。 她就那樣靜靜地躺著纱兑,像睡著了一般呀闻。 火紅的嫁衣襯著肌膚如雪。 梳的紋絲不亂的頭發(fā)上潜慎,一...
    開(kāi)封第一講書人閱讀 49,031評(píng)論 1 285
  • 那天捡多,我揣著相機(jī)與錄音,去河邊找鬼铐炫。 笑死垒手,一個(gè)胖子當(dāng)著我的面吹牛,可吹牛的內(nèi)容都是我干的倒信。 我是一名探鬼主播淫奔,決...
    沈念sama閱讀 38,340評(píng)論 3 399
  • 文/蒼蘭香墨 我猛地睜開(kāi)眼,長(zhǎng)吁一口氣:“原來(lái)是場(chǎng)噩夢(mèng)啊……” “哼堤结!你這毒婦竟也來(lái)了唆迁?” 一聲冷哼從身側(cè)響起鸭丛,我...
    開(kāi)封第一講書人閱讀 36,973評(píng)論 0 259
  • 序言:老撾萬(wàn)榮一對(duì)情侶失蹤,失蹤者是張志新(化名)和其女友劉穎唐责,沒(méi)想到半個(gè)月后鳞溉,有當(dāng)?shù)厝嗽跇?shù)林里發(fā)現(xiàn)了一具尸體,經(jīng)...
    沈念sama閱讀 43,466評(píng)論 1 300
  • 正文 獨(dú)居荒郊野嶺守林人離奇死亡鼠哥,尸身上長(zhǎng)有42處帶血的膿包…… 初始之章·張勛 以下內(nèi)容為張勛視角 年9月15日...
    茶點(diǎn)故事閱讀 35,937評(píng)論 2 323
  • 正文 我和宋清朗相戀三年熟菲,在試婚紗的時(shí)候發(fā)現(xiàn)自己被綠了。 大學(xué)時(shí)的朋友給我發(fā)了我未婚夫和他白月光在一起吃飯的照片朴恳。...
    茶點(diǎn)故事閱讀 38,039評(píng)論 1 333
  • 序言:一個(gè)原本活蹦亂跳的男人離奇死亡抄罕,死狀恐怖,靈堂內(nèi)的尸體忽然破棺而出于颖,到底是詐尸還是另有隱情呆贿,我是刑警寧澤,帶...
    沈念sama閱讀 33,701評(píng)論 4 323
  • 正文 年R本政府宣布森渐,位于F島的核電站做入,受9級(jí)特大地震影響,放射性物質(zhì)發(fā)生泄漏同衣。R本人自食惡果不足惜竟块,卻給世界環(huán)境...
    茶點(diǎn)故事閱讀 39,254評(píng)論 3 307
  • 文/蒙蒙 一、第九天 我趴在偏房一處隱蔽的房頂上張望耐齐。 院中可真熱鬧浪秘,春花似錦、人聲如沸埠况。這莊子的主人今日做“春日...
    開(kāi)封第一講書人閱讀 30,259評(píng)論 0 19
  • 文/蒼蘭香墨 我抬頭看了看天上的太陽(yáng)询枚。三九已至,卻和暖如春浙巫,著一層夾襖步出監(jiān)牢的瞬間金蜀,已是汗流浹背。 一陣腳步聲響...
    開(kāi)封第一講書人閱讀 31,485評(píng)論 1 262
  • 我被黑心中介騙來(lái)泰國(guó)打工的畴, 沒(méi)想到剛下飛機(jī)就差點(diǎn)兒被人妖公主榨干…… 1. 我叫王不留渊抄,地道東北人。 一個(gè)月前我還...
    沈念sama閱讀 45,497評(píng)論 2 354
  • 正文 我出身青樓丧裁,卻偏偏與公主長(zhǎng)得像护桦,于是被迫代替她去往敵國(guó)和親。 傳聞我的和親對(duì)象是個(gè)殘疾皇子煎娇,可洞房花燭夜當(dāng)晚...
    茶點(diǎn)故事閱讀 42,786評(píng)論 2 345

推薦閱讀更多精彩內(nèi)容

  • jvm原理 Java虛擬機(jī)是整個(gè)java平臺(tái)的基石,是java技術(shù)實(shí)現(xiàn)硬件無(wú)關(guān)和操作系統(tǒng)無(wú)關(guān)的關(guān)鍵環(huán)節(jié)催享,是java...
    AI喬治閱讀 17,210評(píng)論 21 486
  • 前言: 由于最近寫的程序在運(yùn)行一段時(shí)間后出現(xiàn)高cpu杭隙,然后不可用故進(jìn)而進(jìn)行排查,最終定位到由于metaspace引...
    Michael_xlp閱讀 22,185評(píng)論 6 17
  • 一因妙,apk以進(jìn)程的形式運(yùn)行痰憎,進(jìn)程的創(chuàng)建是由zygote。 參考文章《深入理解Dalvik虛擬機(jī)- Android應(yīng)...
    Kevin_Junbaozi閱讀 2,817評(píng)論 0 12
  • (1) 和S蹲在街頭攀涵,烤幾串兒羊肉串铣耘,喝幾瓶啤酒,在烤死人的天氣里吃燒烤以故,酣暢的大汗淋漓蜗细。閑談八卦間,幾瓶啤酒已下...
    廖焱閱讀 435評(píng)論 0 1
  • 好久沒(méi)有打過(guò)籃球了据德,大學(xué)操場(chǎng)的橡膠皮味的也兩年多沒(méi)聞過(guò)了鳄乏,曾經(jīng)畢了業(yè)說(shuō)要周游世界,后來(lái)就沒(méi)再想過(guò)了棘利,上學(xué)時(shí)候雖然是...
    王神馬閱讀 153評(píng)論 0 0