Heroku JVM调优

我已经为Heroku编写了一个关于Play2框架的应用程序,并且我遇到了内存问题。

2013-03-21T01:28:35+00:00 heroku[web.1]: Process running mem=543M(106.1%) 2013-03-21T01:28:35+00:00 heroku[web.1]: Error R14 (Memory quota exceeded) 

本地我在Heroku(512MB)上使用相同的JVM设置和内存限制来分析它,但是当我在Heroku发送请求时它几乎立即运行我们的堆空间。

 JAVA_OPTS: -Xmx384m -Xss512k -XX:+UseCompressedOops 

如果我能分析那里发生了什么,我就不会有任何问题,但java-agent doest似乎对我有用。

我没有遇到任何我见过的内存泄漏。 我知道我创造的每个物体都只会被使用一次,所以我可以让我的年轻一代变大,而我的老一代变小。 我已经尝试了不同的JVM值,但似乎无法找到正确的组合,以便在没有正确的分析的情况下使其工作。

我已经阅读了所有关于调优的Heroku文档,但没有用。 有没有人对此有任何想法,或者可能指出我正确的方向?

编辑

我仍然无法使远程监控工作,但是在完整的CG之前和之后,我的本地测试系统有一些转储。

 {Heap before GC invocations=1747 (full 0): PSYoungGen total 42496K, used 42496K [0x00000000f5560000, 0x00000000fded0000, 0x0000000100000000) eden space 42176K, 100% used [0x00000000f5560000,0x00000000f7e90000,0x00000000f7e90000) from space 320K, 100% used [0x00000000fde80000,0x00000000fded0000,0x00000000fded0000) to space 640K, 0% used [0x00000000fdd90000,0x00000000fdd90000,0x00000000fde30000) PSOldGen total 106176K, used 105985K [0x00000000e0000000, 0x00000000e67b0000, 0x00000000f5560000) object space 106176K, 99% used [0x00000000e0000000,0x00000000e67804c8,0x00000000e67b0000) PSPermGen total 43712K, used 43684K [0x00000000d5a00000, 0x00000000d84b0000, 0x00000000e0000000) object space 43712K, 99% used [0x00000000d5a00000,0x00000000d84a9338,0x00000000d84b0000) 2013-03-21T14:09:36.827-0700: [GC [PSYoungGen: 42496K->384K(41536K)] 148481K->106450K(147712K), 0.0027940 secs] [Times: user=0.02 sys=0.00, real=0.00 secs] Heap after GC invocations=1747 (full 0): PSYoungGen total 41536K, used 384K [0x00000000f5560000, 0x00000000fde90000, 0x0000000100000000) eden space 41152K, 0% used [0x00000000f5560000,0x00000000f5560000,0x00000000f7d90000) from space 384K, 100% used [0x00000000fdd90000,0x00000000fddf0000,0x00000000fddf0000) to space 640K, 0% used [0x00000000fddf0000,0x00000000fddf0000,0x00000000fde90000) PSOldGen total 106176K, used 106066K [0x00000000e0000000, 0x00000000e67b0000, 0x00000000f5560000) object space 106176K, 99% used [0x00000000e0000000,0x00000000e6794968,0x00000000e67b0000) PSPermGen total 43712K, used 43684K [0x00000000d5a00000, 0x00000000d84b0000, 0x00000000e0000000) object space 43712K, 99% used [0x00000000d5a00000,0x00000000d84a9338,0x00000000d84b0000) } {Heap before GC invocations=1748 (full 1): PSYoungGen total 41536K, used 384K [0x00000000f5560000, 0x00000000fde90000, 0x0000000100000000) eden space 41152K, 0% used [0x00000000f5560000,0x00000000f5560000,0x00000000f7d90000) from space 384K, 100% used [0x00000000fdd90000,0x00000000fddf0000,0x00000000fddf0000) to space 640K, 0% used [0x00000000fddf0000,0x00000000fddf0000,0x00000000fde90000) PSOldGen total 106176K, used 106066K [0x00000000e0000000, 0x00000000e67b0000, 0x00000000f5560000) object space 106176K, 99% used [0x00000000e0000000,0x00000000e6794968,0x00000000e67b0000) PSPermGen total 43712K, used 43684K [0x00000000d5a00000, 0x00000000d84b0000, 0x00000000e0000000) object space 43712K, 99% used [0x00000000d5a00000,0x00000000d84a9338,0x00000000d84b0000) 2013-03-21T14:09:36.830-0700: [Full GC [PSYoungGen: 384K->0K(41536K)] [PSOldGen: 106066K->13137K(52224K)] 106450K->13137K(93760K) [PSPermGen: 43684K->43684K(87936K)], 0.0666250 secs] [Times: user=0.06 sys=0.01, real=0.07 secs] Heap after GC invocations=1748 (full 1): PSYoungGen total 41536K, used 0K [0x00000000f5560000, 0x00000000fde90000, 0x0000000100000000) eden space 41152K, 0% used [0x00000000f5560000,0x00000000f5560000,0x00000000f7d90000) from space 384K, 0% used [0x00000000fdd90000,0x00000000fdd90000,0x00000000fddf0000) to space 640K, 0% used [0x00000000fddf0000,0x00000000fddf0000,0x00000000fde90000) PSOldGen total 52224K, used 13137K [0x00000000e0000000, 0x00000000e3300000, 0x00000000f5560000) object space 52224K, 25% used [0x00000000e0000000,0x00000000e0cd4528,0x00000000e3300000) PSPermGen total 87936K, used 43684K [0x00000000d5a00000, 0x00000000dafe0000, 0x00000000e0000000) object space 87936K, 49% used [0x00000000d5a00000,0x00000000d84a9338,0x00000000dafe0000) } 

编辑

这是我能得到的 – 这不是很多,但这是在100个请求之后发生的事情,因为一切都开始降级,你可以看到web.2已经在这个转储中交换

 2013-03-21T22:24:23+00:00 heroku[web.1]: source=heroku.13369226.web.1.d615093e-77a3-42b1-8da1-a228bd7582a1 measure=load_avg_1m val=0.41 2013-03-21T22:24:23+00:00 heroku[web.1]: source=heroku.13369226.web.1.d615093e-77a3-42b1-8da1-a228bd7582a1 measure=memory_total val=246.95 units=MB 2013-03-21T22:24:23+00:00 heroku[web.1]: source=heroku.13369226.web.1.d615093e-77a3-42b1-8da1-a228bd7582a1 measure=memory_rss val=246.91 units=MB 2013-03-21T22:24:23+00:00 heroku[web.1]: source=heroku.13369226.web.1.d615093e-77a3-42b1-8da1-a228bd7582a1 measure=memory_cache val=0.05 units=MB 2013-03-21T22:24:23+00:00 heroku[web.1]: source=heroku.13369226.web.1.d615093e-77a3-42b1-8da1-a228bd7582a1 measure=memory_swap val=0.00 units=MB 2013-03-21T22:24:23+00:00 heroku[web.1]: source=heroku.13369226.web.1.d615093e-77a3-42b1-8da1-a228bd7582a1 measure=memory_pgpgin val=72259 units=pages 2013-03-21T22:24:23+00:00 heroku[web.1]: source=heroku.13369226.web.1.d615093e-77a3-42b1-8da1-a228bd7582a1 measure=memory_pgpgout val=9039 units=pages 2013-03-21T22:24:25+00:00 heroku[web.2]: source=heroku.13369226.web.2.cb423d08-dd15-41c1-9843-95bcdc269111 measure=load_avg_1m val=0.30 2013-03-21T22:24:25+00:00 heroku[web.2]: source=heroku.13369226.web.2.cb423d08-dd15-41c1-9843-95bcdc269111 measure=memory_total val=532.83 units=MB 2013-03-21T22:24:25+00:00 heroku[web.2]: source=heroku.13369226.web.2.cb423d08-dd15-41c1-9843-95bcdc269111 measure=memory_rss val=511.86 units=MB 2013-03-21T22:24:25+00:00 heroku[web.2]: source=heroku.13369226.web.2.cb423d08-dd15-41c1-9843-95bcdc269111 measure=memory_cache val=0.04 units=MB 2013-03-21T22:24:25+00:00 heroku[web.2]: source=heroku.13369226.web.2.cb423d08-dd15-41c1-9843-95bcdc269111 measure=memory_swap val=20.93 units=MB 2013-03-21T22:24:25+00:00 heroku[web.2]: source=heroku.13369226.web.2.cb423d08-dd15-41c1-9843-95bcdc269111 measure=memory_pgpgin val=145460 units=pages 2013-03-21T22:24:25+00:00 heroku[web.2]: source=heroku.13369226.web.2.cb423d08-dd15-41c1-9843-95bcdc269111 measure=memory_pgpgout val=14414 units=pages 2013-03-21T22:24:25+00:00 heroku[web.2]: Process running mem=532M(104.1%) 2013-03-21T22:24:25+00:00 heroku[web.2]: Error R14 (Memory quota exceeded) 2013-03-21T22:24:29+00:00 heroku[web.4]: source=heroku.13369226.web.4.25274242-a3af-4d2e-9da3-44e5e0a45c09 measure=load_avg_1m val=1.83 2013-03-21T22:24:29+00:00 heroku[web.4]: source=heroku.13369226.web.4.25274242-a3af-4d2e-9da3-44e5e0a45c09 measure=memory_total val=400.66 units=MB 2013-03-21T22:24:29+00:00 heroku[web.4]: source=heroku.13369226.web.4.25274242-a3af-4d2e-9da3-44e5e0a45c09 measure=memory_rss val=400.61 units=MB 2013-03-21T22:24:29+00:00 heroku[web.4]: source=heroku.13369226.web.4.25274242-a3af-4d2e-9da3-44e5e0a45c09 measure=memory_cache val=0.05 units=MB 2013-03-21T22:24:29+00:00 heroku[web.4]: source=heroku.13369226.web.4.25274242-a3af-4d2e-9da3-44e5e0a45c09 measure=memory_swap val=0.00 units=MB 2013-03-21T22:24:29+00:00 heroku[web.4]: source=heroku.13369226.web.4.25274242-a3af-4d2e-9da3-44e5e0a45c09 measure=memory_pgpgin val=113336 units=pages 2013-03-21T22:24:29+00:00 heroku[web.4]: source=heroku.13369226.web.4.25274242-a3af-4d2e-9da3-44e5e0a45c09 measure=memory_pgpgout val=10767 units=pages 2013-03-21T22:24:29+00:00 heroku[web.3]: source=heroku.13369226.web.3.2132f01f-94b1-4151-8fa8-09cdb2774919 measure=load_avg_1m val=0.25 2013-03-21T22:24:29+00:00 heroku[web.3]: source=heroku.13369226.web.3.2132f01f-94b1-4151-8fa8-09cdb2774919 measure=memory_total val=397.70 units=MB 2013-03-21T22:24:29+00:00 heroku[web.3]: source=heroku.13369226.web.3.2132f01f-94b1-4151-8fa8-09cdb2774919 measure=memory_rss val=397.64 units=MB 2013-03-21T22:24:29+00:00 heroku[web.3]: source=heroku.13369226.web.3.2132f01f-94b1-4151-8fa8-09cdb2774919 measure=memory_cache val=0.05 units=MB 2013-03-21T22:24:29+00:00 heroku[web.3]: source=heroku.13369226.web.3.2132f01f-94b1-4151-8fa8-09cdb2774919 measure=memory_swap val=0.00 units=MB 2013-03-21T22:24:29+00:00 heroku[web.3]: source=heroku.13369226.web.3.2132f01f-94b1-4151-8fa8-09cdb2774919 measure=memory_pgpgin val=112163 units=pages 2013-03-21T22:24:29+00:00 heroku[web.3]: source=heroku.13369226.web.3.2132f01f-94b1-4151-8fa8-09cdb2774919 measure=memory_pgpgout val=10353 units=pages 

我遇到过同样的问题。 Heroku告诉你机器内存不足,而不是Java VM。 Heroku Play 2.2部署实际上存在一个错误,启动脚本读取java_opts,而不是JAVA_OPTS。

我通过设置两个来修复它:

 heroku config:add java_opts='-Xmx384m -Xms384m -Xss512k -XX:+UseCompressedOops' heroku config:add JAVA_OPTS='-Xmx384m -Xms384m -Xss512k -XX:+UseCompressedOops' 

我还必须设置-Xms,否则我得到一个错误,说min和max是不兼容的。 我猜Play2.2使用的默认值高于384米。

要找出你使用的总内存, 这是一个有用的等式 (pre java 8):

Max memory = [-Xmx] + [-XX:MaxPermSize] + number_of_threads * [-Xss]

此Heroku devcenter文章中有3个诊断工具可能会对您有所帮助: https ://devcenter.heroku.com/articles/java-memory-issues

查看内存日志记录代理,详细GC标记和log-runtime-metrics( https://devcenter.heroku.com/articles/log-runtime-metrics )。 那些应该给你一些更多的可见性。

你忘了考虑Permgen(pre-JRE 8)或Metaspace (JRE-8 +)内存需求; 这是为Java类信息和某些静态信息保留的内存。 在堆上计划它是另一个100-150MB,看起来你的更高。 您可以使用-XX:MaxMetaspaceSize标志限制它,但请注意,如果超过该限制,您将收到错误。

我有一个服务器也限制在-Xmx384M,事实certificate,实际内存使用量也大约为500 MB(但对于更复杂的应用程序会更高),并考虑到Metaspace。它正在运行一个相当复杂的应用程序(Jenkins),所以元空间大小最终约为170 MB,其中堆达到了极限,使用了554 MB的RAM。