【发布时间】:2018-06-01 20:31:44
【问题描述】:
我们有一个在 Docker 中运行的 Java 应用程序。它有时会被 oom-killer 杀死,即使所有 JVM 统计数据看起来都不错。我们还有许多其他应用程序没有此类问题。
我们的设置:
- 容器大小限制:480MB
- JVM 堆限制:250MB
- JVM 元空间限制:100MB
JVM 报告的各种内存统计信息(我们每 10 秒获取一次数据):
来自容器的日志(可能有点不按顺序,因为我们用相同的时间戳获取它们):
java invoked oom-killer: gfp_mask=0xd0, order=0, oom_score_adj=0
java cpuset=47cfa4d013add110d949e164c3714a148a0cd746bd53bb4bafab139bc59c1149 mems_allowed=0
CPU: 5 PID: 12963 Comm: java Tainted: G ------------ T 3.10.0-514.2.2.el7.x86_64 #1
Hardware name: VMware, Inc. VMware Virtual Platform/440BX Desktop Reference Platform, BIOS 6.00 04/14/2014
0000000000000000 0000000000000000 0000000000000046 ffffffff811842b6
ffff88010c1baf10 000000001764470e ffff88020c033cc0 ffffffff816861cc
ffff88020c033d50 ffffffff81681177 ffff880809654980 0000000000000001
Call Trace:
[<ffffffff816861cc>] dump_stack+0x19/0x1b
[<ffffffff81681177>] dump_header+0x8e/0x225
[<ffffffff8118476e>] oom_kill_process+0x24e/0x3c0
[<ffffffff810937ee>] ? has_capability_noaudit+0x1e/0x30
[<ffffffff811842b6>] ? find_lock_task_mm+0x56/0xc0
[<ffffffff811f3131>] mem_cgroup_oom_synchronize+0x551/0x580
[<ffffffff811f2580>] ? mem_cgroup_charge_common+0xc0/0xc0
[<ffffffff81184ff4>] pagefault_out_of_memory+0x14/0x90
[<ffffffff8167ef67>] mm_fault_error+0x68/0x12b
[<ffffffff81691ed5>] __do_page_fault+0x395/0x450
[<ffffffff81691fc5>] do_page_fault+0x35/0x90
[<ffffffff8168e288>] page_fault+0x28/0x30
Task in /docker/47cfa4d013add110d949e164c3714a148a0cd746bd53bb4bafab139bc59c1149 killed as a result of limit of /docker/47cfa4d013add110d949e164c3714a148a0cd746bd53bb4bafab139bc59c1149
memory: usage 491520kB, limit 491520kB, failcnt 28542
memory+swap: usage 578944kB, limit 983040kB, failcnt 0
kmem: usage 0kB, limit 9007199254740988kB, failcnt 0
Memory cgroup stats for /docker/47cfa4d013add110d949e164c3714a148a0cd746bd53bb4bafab139bc59c1149: cache:32KB rss:491488KB rss_huge:2048KB mapped_file:8KB swap:87424KB inactive_anon:245948KB active_anon:245660KB inactive_file:4KB active_file:4KB unevictable:0KB
[ pid ] uid tgid total_vm rss nr_ptes swapents oom_score_adj name
[12588] 0 12588 46 0 4 4 0 s6-svscan
[12656] 0 12656 46 0 4 4 0 s6-supervise
[12909] 0 12909 46 0 4 3 0 s6-supervise
[12910] 0 12910 46 0 4 4 0 s6-supervise
[12913] 0 12913 1541 207 7 51 0 bash
[12914] 0 12914 1542 206 8 52 0 bash
[12923] 10001 12923 9379 3833 23 808 0 telegraf
[12927] 10001 12927 611126 112606 588 23134 0 java
Memory cgroup out of memory: Kill process 28767 (java) score 554 or sacrifice child
Killed process 12927 (java) total-vm:2444504kB, anon-rss:440564kB, file-rss:9860kB, shmem-rss:0kB
请注意,JVM 本身不会报告任何内存不足错误。
JVM 报告的统计数据显示 240MB 堆限制和 140MB 非堆使用,加起来只有 380MB,剩下 100MB 内存用于其他进程(主要是 telegraf)和 JVM 堆栈(我们认为问题可能是一个数字线程提高,但从统计数据来看,这似乎不是问题)。
Oom-killer 显示一堆与我们的任何设置和其他统计信息都不匹配的数字(页面大小默认为 4kB):
- JVM 总虚拟机:611126 (2.44GB)
- JVM RSS:112606 (450MB)
- JVM anon-rss:440MB
- JVM 文件-rss:10MB
- 其他进程总计 rss:4246 (17MB)
- 容器内存限制:491.5MB
以下是问题:
- JVM 报告内存使用量为 380MB,但 oom-killer 说此进程正在使用 450MB。丢失的 70MB 可能在哪里?
- 容器应该还有 30MB 剩余并且 oom-killer 说其他进程只使用了 17MB,所以应该还有 13MB 空闲内存,但是它说容器大小等于容器限制。丢失的 13MB 可能在哪里?
我看到类似的问题,建议 Java 应用程序可能会分叉其他进程并使用操作系统的内存,这不会显示在 JVM 内存使用情况中。我们自己不这样做,但我们仍在审查和测试我们的任何库是否可能这样做。无论如何,这是对第一个问题的一个很好的解释,但第二个问题对我来说仍然是一个谜。
【问题讨论】:
-
您使用什么工具来收集 JVM 指标作为图像?
-
@EderF.Freitas 我们不收集 JVM 指标作为图像。数据的可视化由 Grafana 完成。
-
那么您找到原因了吗?我们面临着非常相似的问题
-
@user2105282 很抱歉,那是不久前的事了,我不记得了。看看下面的答案 - 我可以看到我对它们都投了赞成票,这意味着它们在某种程度上很有用。
标签: linux docker memory out-of-memory java-memory-model