尽管有可用内存(缓存),但 OOM

Yan*_*ang 13 postgresql oom

尽管我们将近一半的内存用于 FS 缓存,但我们还是遇到了 OOM 杀手。我们每分钟记录一次内存统计信息(如 top 所报告的),但似乎有很多可用性。

...

Mem:  15339640k total, 15268304k used,    71336k free,     3152k buffers
Swap:        0k total,        0k used,        0k free,  6608384k cached

Mem:  15339640k total, 14855280k used,   484360k free,    13748k buffers
Swap:        0k total,        0k used,        0k free,  6481852k cached

[OOM killer: postgres killed]

Mem:  15339640k total,  8212200k used,  7127440k free,    32776k buffers
Swap:        0k total,        0k used,        0k free,  2394444k cached

...
Run Code Online (Sandbox Code Playgroud)

来自系统日志的 OOM 详细信息:

...
Jun 10 05:45:25 db kernel: [11209156.840462] wal-e invoked oom-killer: gfp_mask=0x201da, order=0, oom_adj=0, oom_score_adj=0
Jun 10 05:45:25 db kernel: [11209156.840469] wal-e cpuset=/ mems_allowed=0
Jun 10 05:45:25 db kernel: [11209156.840474] Pid: 7963, comm: wal-e Not tainted 3.2.0-43-virtual #68-Ubuntu
Jun 10 05:45:25 db kernel: [11209156.840477] Call Trace:
Jun 10 05:45:25 db kernel: [11209156.840498]  [<ffffffff81119711>] dump_header+0x91/0xe0
Jun 10 05:45:25 db kernel: [11209156.840502]  [<ffffffff81119a95>] oom_kill_process+0x85/0xb0
Jun 10 05:45:25 db kernel: [11209156.840506]  [<ffffffff81119e3a>] out_of_memory+0xfa/0x220
Jun 10 05:45:25 db kernel: [11209156.840511]  [<ffffffff8111f823>] __alloc_pages_nodemask+0x8c3/0x8e0
Jun 10 05:45:25 db kernel: [11209156.840520]  [<ffffffff81216e00>] ? noalloc_get_block_write+0x30/0x30
Jun 10 05:45:25 db kernel: [11209156.840528]  [<ffffffff811566c6>] alloc_pages_current+0xb6/0x120
Jun 10 05:45:25 db kernel: [11209156.840534]  [<ffffffff81116637>] __page_cache_alloc+0xb7/0xd0
Jun 10 05:45:25 db kernel: [11209156.840539]  [<ffffffff81118602>] filemap_fault+0x212/0x3c0
Jun 10 05:45:25 db kernel: [11209156.840553]  [<ffffffff81138c32>] __do_fault+0x72/0x550
Jun 10 05:45:25 db kernel: [11209156.840557]  [<ffffffff8113c2ea>] handle_pte_fault+0xfa/0x200
Jun 10 05:45:25 db kernel: [11209156.840562]  [<ffffffff8100638e>] ? xen_pmd_val+0xe/0x10
Jun 10 05:45:25 db kernel: [11209156.840567]  [<ffffffff81005309>] ? __raw_callee_save_xen_pmd_val+0x11/0x1e
Jun 10 05:45:25 db kernel: [11209156.840571]  [<ffffffff8113d559>] handle_mm_fault+0x269/0x370
Jun 10 05:45:25 db kernel: [11209156.840576]  [<ffffffff8100a56d>] ? xen_force_evtchn_callback+0xd/0x10
Jun 10 05:45:25 db kernel: [11209156.840581]  [<ffffffff8100ad42>] ? check_events+0x12/0x20
Jun 10 05:45:25 db kernel: [11209156.840589]  [<ffffffff8165b3cb>] do_page_fault+0x14b/0x520
Jun 10 05:45:25 db kernel: [11209156.840594]  [<ffffffff81160d64>] ? kmem_cache_free+0x104/0x110
Jun 10 05:45:25 db kernel: [11209156.840600]  [<ffffffff811ba2c8>] ? ep_remove+0xa8/0xc0
Jun 10 05:45:25 db kernel: [11209156.840604]  [<ffffffff811bb133>] ? sys_epoll_ctl+0xb3/0x3d0
Jun 10 05:45:25 db kernel: [11209156.840614]  [<ffffffff81658035>] page_fault+0x25/0x30
Jun 10 05:45:25 db kernel: [11209156.840617] Mem-Info:
Jun 10 05:45:25 db kernel: [11209156.840618] Node 0 DMA per-cpu:
Jun 10 05:45:25 db kernel: [11209156.840622] CPU    0: hi:    0, btch:   1 usd:   0
Jun 10 05:45:25 db kernel: [11209156.840624] CPU    1: hi:    0, btch:   1 usd:   0
Jun 10 05:45:25 db kernel: [11209156.840627] CPU    2: hi:    0, btch:   1 usd:   0
Jun 10 05:45:25 db kernel: [11209156.840629] CPU    3: hi:    0, btch:   1 usd:   0
Jun 10 05:45:25 db kernel: [11209156.840631] Node 0 DMA32 per-cpu:
Jun 10 05:45:25 db kernel: [11209156.840634] CPU    0: hi:  186, btch:  31 usd:  30
Jun 10 05:45:25 db kernel: [11209156.840637] CPU    1: hi:  186, btch:  31 usd:  47
Jun 10 05:45:25 db kernel: [11209156.840639] CPU    2: hi:  186, btch:  31 usd:  15
Jun 10 05:45:25 db kernel: [11209156.840641] CPU    3: hi:  186, btch:  31 usd:   2
Jun 10 05:45:25 db kernel: [11209156.840643] Node 0 Normal per-cpu:
Jun 10 05:45:25 db kernel: [11209156.840646] CPU    0: hi:  186, btch:  31 usd:   0
Jun 10 05:45:25 db kernel: [11209156.840648] CPU    1: hi:  186, btch:  31 usd:  14
Jun 10 05:45:25 db kernel: [11209156.840650] CPU    2: hi:  186, btch:  31 usd:   0
Jun 10 05:45:25 db kernel: [11209156.840653] CPU    3: hi:  186, btch:  31 usd:   1
Jun 10 05:45:25 db kernel: [11209156.840658] active_anon:3616567 inactive_anon:4798 isolated_anon:0
Jun 10 05:45:25 db kernel: [11209156.840660]  active_file:98 inactive_file:168 isolated_file:20
Jun 10 05:45:25 db kernel: [11209156.840661]  unevictable:1597 dirty:73 writeback:0 unstable:0
Jun 10 05:45:25 db kernel: [11209156.840662]  free:16921 slab_reclaimable:17631 slab_unreclaimable:7534
Jun 10 05:45:25 db kernel: [11209156.840663]  mapped:1614529 shmem:1613928 pagetables:124012 bounce:0
Jun 10 05:45:25 db kernel: [11209156.840666] Node 0 DMA free:7888kB min:4kB low:4kB high:4kB active_anon:0kB inactive_anon:0kB active_file:0kB inactive_file:0kB unevictable:0kB isolated(anon):0kB isolated(file):0kB present:7632kB mlocked:0kB dirty:0kB writeback:0kB mapped:0kB shmem:0kB slab_reclaimable:0kB slab_unreclaimable:0kB kernel_stack:0kB pagetables:0kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:0 all_unreclaimable? yes
Jun 10 05:45:25 db kernel: [11209156.840681] lowmem_reserve[]: 0 4016 15112 15112
Jun 10 05:45:25 db kernel: [11209156.840686] Node 0 DMA32 free:48368kB min:4176kB low:5220kB high:6264kB active_anon:3776804kB inactive_anon:28kB active_file:0kB inactive_file:20kB unevictable:932kB isolated(anon):0kB isolated(file):0kB present:4112640kB mlocked:932kB dirty:0kB writeback:0kB mapped:1458536kB shmem:1458632kB slab_reclaimable:17604kB slab_unreclaimable:8088kB kernel_stack:1872kB pagetables:190616kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:437 all_unreclaimable? yes
Jun 10 05:45:25 db kernel: [11209156.840698] lowmem_reserve[]: 0 0 11095 11095
Jun 10 05:45:25 db kernel: [11209156.840703] Node 0 Normal free:11428kB min:11548kB low:14432kB high:17320kB active_anon:10689464kB inactive_anon:19164kB active_file:528kB inactive_file:652kB unevictable:5456kB isolated(anon):0kB isolated(file):80kB present:11362176kB mlocked:5456kB dirty:292kB writeback:0kB mapped:4999580kB shmem:4997080kB slab_reclaimable:52920kB slab_unreclaimable:22048kB kernel_stack:2584kB pagetables:305432kB unstable:0kB bounce:0kB writeback_tmp:0kB pages_scanned:1974 all_unreclaimable? yes
Jun 10 05:45:25 db kernel: [11209156.840715] lowmem_reserve[]: 0 0 0 0
Jun 10 05:45:25 db kernel: [11209156.840720] Node 0 DMA: 2*4kB 3*8kB 1*16kB 3*32kB 3*64kB 3*128kB 2*256kB 1*512kB 2*1024kB 2*2048kB 0*4096kB = 7888kB
Jun 10 05:45:25 db kernel: [11209156.840752] Node 0 DMA32: 5813*4kB 2636*8kB 114*16kB 15*32kB 5*64kB 1*128kB 1*256kB 0*512kB 1*1024kB 0*2048kB 0*4096kB = 48372kB
Jun 10 05:45:25 db kernel: [11209156.840776] Node 0 Normal: 1888*4kB 10*8kB 46*16kB 4*32kB 3*64kB 2*128kB 1*256kB 1*512kB 0*1024kB 1*2048kB 0*4096kB = 11760kB
Jun 10 05:45:25 db kernel: [11209156.840788] 1615243 total pagecache pages
Jun 10 05:45:25 db kernel: [11209156.840790] 0 pages in swap cache
Jun 10 05:45:25 db kernel: [11209156.840801] Swap cache stats: add 0, delete 0, find 0/0
Jun 10 05:45:25 db kernel: [11209156.840803] Free swap  = 0kB
Jun 10 05:45:25 db kernel: [11209156.840805] Total swap = 0kB
Jun 10 05:45:25 db kernel: [11209156.909794] 3934192 pages RAM
Jun 10 05:45:25 db kernel: [11209156.909804] 99282 pages reserved
Jun 10 05:45:25 db kernel: [11209156.909809] 18899146 pages shared
Jun 10 05:45:25 db kernel: [11209156.909811] 2198511 pages non-shared
Jun 10 05:45:25 db kernel: [11209156.909817] [ pid ]   uid  tgid total_vm      rss cpu oom_adj oom_score_adj name
Jun 10 05:45:25 db kernel: [11209156.909835] [  332]     0   332     4308      109   1       0             0 upstart-udev-br
Jun 10 05:45:25 db kernel: [11209156.909845] [  346]     0   346     5384      271   2     -17         -1000 udevd
Jun 10 05:45:25 db kernel: [11209156.909851] [  408]     0   408     5364      174   2     -17         -1000 udevd
...
Jun 10 05:45:25 db kernel: [11209156.910703] [ 7963]   111  7963    17456     2966   0       0             0 wal-e
Jun 10 05:45:25 db kernel: [11209156.910707] [ 7968]   111  7968  1639372     2351   3       0             0 postgres
Jun 10 05:45:25 db kernel: [11209156.910711] [ 7969]   111  7969  1639371     1934   2       0             0 postgres
Jun 10 05:45:25 db kernel: [11209156.910716] Out of memory: Kill process 12443 (postgres) score 418 or sacrifice child
Jun 10 05:45:25 db kernel: [11209156.910733] Killed process 12443 (postgres) total-vm:6555152kB, anon-rss:4600kB, file-rss:6396572kB
Jun 10 05:45:30 db kernel: [11209159.293083] postgres invoked oom-killer: gfp_mask=0x201da, order=0, oom_adj=0, oom_score_adj=0
Jun 10 05:45:31 db kernel: [11209159.293091] postgres cpuset=/ mems_allowed=0
Jun 10 05:45:31 db kernel: [11209159.293095] Pid: 6508, comm: postgres Not tainted 3.2.0-43-virtual #68-Ubuntu
Jun 10 05:45:31 db kernel: [11209159.293098] Call Trace:
Jun 10 05:45:31 db kernel: [11209159.293111]  [<ffffffff81119711>] dump_header+0x91/0xe0
Jun 10 05:45:31 db kernel: [11209159.293115]  [<ffffffff81119a95>] oom_kill_process+0x85/0xb0
Jun 10 05:45:31 db kernel: [11209159.293119]  [<ffffffff81119e3a>] out_of_memory+0xfa/0x220
...
Run Code Online (Sandbox Code Playgroud)

我们可以尝试将这些分辨率提高到大约每秒一次,但是这里有什么 OOM 的原因吗?(我们已经看到了http://bl0rg.krunch.be/oom-frag.html,但我们正在使用更大的绝对内存量,其中大部分被内核的 FS 缓存占用。)

还包括我们postgresql.conf下面的相关部分:

shared_buffers = 6GB
effective_cache_size = 8GB
Run Code Online (Sandbox Code Playgroud)

vor*_*aq7 8

  1. 为了热爱世界上的一切美好事物,请在您的服务器上配置交换空间
    你真的需要交换空间我不是唯一这么说的人这几乎是这里的普遍真理。(<-- 这是三个链接)
    您当然应该有足够的 RAM,您的数据库服务器不会定期交换- 如果您不这样做,解决方案就是金钱(您将您的供应商带到您的供应商并用于获得更多 RAM) .

  2. 由于您现在有足够的 RAM,并且在出现问题时交换使用,您可以禁用 OOM 杀手(通过禁用内存过度使用),就像 Postgres 的人告诉您的那样
    (您也可以应用他们的替代解决方案并告诉 OOM-Killer 永远不要杀死 Postgres - 但是您只是在用系统的其余进程玩俄罗斯轮盘赌......)

  3. (可选)写一个关于服务器故障的答案,详细说明为什么大多数 Linux 发行版中的默认行为是坏的、错误的,并且违反了关于 malloc() 应该如何表现的 POSIX 规范。重复它,直到每个人都厌倦了听到它。


另请注意,内核的缓存内存可供 postgres(或任何其他应用程序)使用 - 您应该在计算中将其视为可用/可用内存。

如果我不得不猜测这里发生了什么,我会说你有一个复杂的查询,Postgres 正在请求 RAM 来执行它,而不是说“我没有那个 RAM” Linux 告诉 Postgres“当然,你可以拥有它。”
然后,当Postgres的实际上是尝试使用的RAM是(据说)给出的Linux实现不HAVE它所承诺的Postgres的RAM(因为它是过量使用) -的OOM杀手被告知要释放的内存,并使用尽职尽责地杀死程序最多的内存——你的数据库服务器。

Postgres 是一个精心设计的程序。如果它被告知它不能拥有它所请求的 RAM,它将优雅地处理它(通过减少使用,或中止向用户发送消息)。

  • 感谢您对交换的详细说明,但这 ** 并没有回答我的问题,即为什么会发生这种情况**。是的,我理解 Linux 默认过量使用的基本前提,OOM 是当我们的 RAM 用完时 - 我可以在我原来的问题中说明这么多。但问题是**为什么当我仍然有足够的 RAM 时它会启动**(其中大部分只是位于 FS 缓存中)?假设我什至对改变任何东西都不感兴趣——OOM 杀手很好,只要我明白它为什么被触发。 (4认同)
  • 查看链接后,不幸的是,有许多断言没有支持证据或具体的技术解释。当然,在许多 Linux 环境中,交换甚至不是一个选项(例如:看看 Live CD,那里没有现有的本地交换分区可以重用)。此外,我们对基于我们自己的经验和环境启用交换不感兴趣 - 我们宁愿拥有 OOM。对原始问题的回答将不胜感激。 (2认同)
  • 我在确实有交换的服务器上遇到过这种情况,在使可用内存+交换饱和后,使用 OOM 杀手而不是内核回收“缓存”内存,这显然以某种方式被锁定。我从来没有解决过这个问题,但@Yang 的原始问题在这里没有得到解答。 (2认同)
  • 交换不是答案,它只会让问题稍后出现。当 RAM 已满时您需要交换,而当 RAM+交换已满时您需要 OOM Killer。如果交换量为零,则您会更快地需要 OOM Killer,但您无法通过交换避免 OOM Killer。 (2认同)

Nic*_*lay 5

看来您(和我在一个症状非常相似的情况下)确实内存不足并且被数字弄糊涂了cached

显然,当内存需求上升Linux 没有释放大磁盘缓存的情况

特别是(我真的不明白为什么),postgres'shared_buffers可能会在“缓存”(页面缓存)下报告。在您的情况下,6481852k cached输入top匹配 OOM-killer 日志中的这一行:

Jun 10 05:45:25 db kernel: [11209156.840788] 1615243 total pagecache pages
Run Code Online (Sandbox Code Playgroud)

(1615243*4KB ~= 6481852k) - 这意味着在调用 OOM-killer 之前确实没有删除页面缓存。

然而,文件支持的页面很少(我认为active_file:98 inactive_file:168类似于 /proc/meminfo 的Active(file)/Inactive(file)),所以它不是我们所知道和喜爱的可丢弃页面。

https://www.depesz.com/2012/06/09/how-much-ram-is-postgresql-using/ 上的帖子演示了一个示例会话,其中关闭 postgres 导致“缓存”的大小减少shared_buffers(滚动到“并且大部分都来自磁盘缓存 - 正如预期的那样,因为它用于 shared_buffers。”) - 不幸的是,它没有表明 postgres 的版本,也没有用于实验的内核。

我在 PG 9.3 中使用 3.13.0-67 x86_64。在 9.3 中,他们从使用 Sys V 共享内存 ( shmget)切换到匿名mmap(...R+W, MAP_SHARED|MAP_ANONYMOUS|MAP_HASSEMAPHORE...)+fork()(在 9.4 中,这可以通过dynamic_shared_memory_type 进行配置)。但是我找不到任何关于为什么这些 mmap() 应该出现在“缓存”中的解释以及为什么,只有https://access.redhat.com/solutions/406773说“缓存:内存中的页面缓存(磁盘缓存和共享内存)”

鉴于有多种共享记忆,我既开明又困惑......


归档时间:

查看次数:

10228 次

最近记录:

8 年,4 月 前