问题说明

最近的几台机器在同一天的不同时段都出现以下警告信息:

Mar 26 20:55:03 host1 kernel: WARNING: at fs/xfs/xfs_aops.c:1045 xfs_vm_releasepage+0xcb/0x100 [xfs]()Mar 26 20:55:03 host1 kernel: Modules linked in: nf_conntrack_ipv4 nf_defrag_ipv4 xt_conntrack nf_conntrack iptable_filter ip_tables ebtable_filter ebtables ip6table_filter ip6_tables devlink bridge stp llc xt_multiport sunrpc dm_mirror dm_region_hash dm_log dm_mod intel_powerclamp coretemp intel_rapl iosf_mbi kvm_intel kvm irqbypass crc32_pclmul ghash_clmulni_intel aesni_intel lrw gf128mul glue_helper ablk_helper cryptd iTCO_wdt iTCO_vendor_support dcdbas ipmi_devintf ipmi_si sg pcspkr ipmi_msghandler shpchp i2c_i801 lpc_ich nfit libnvdimm acpi_power_meter kgwttm(OE) xfs libcrc32c sd_mod crc_t10dif crct10dif_generic crct10dif_pclmul crct10dif_common crc32c_intel mgag200 drm_kms_helper igb syscopyarea sysfillrect sysimgblt ptp fb_sys_fops ttm pps_core dca ahci drm i2c_algo_bit libahci megaraid_sas i2c_core libataMar 26 20:55:03 host1 kernel: fjes [last unloaded: nf_defrag_ipv4]Mar 26 20:55:03 host1 kernel: CPU: 10 PID: 224 Comm: kswapd0 Tainted: G OE ------------ 3.10.0-514.21.2.el7.x86_64 #1Mar 26 20:55:03 host1 kernel: Hardware name: Dell Inc. PowerEdge R640/0W23H8, BIOS 1.3.7 02/08/2018Mar 26 20:55:03 host1 kernel: 0000000000000000 00000000e02a0d05 ffff88103c7ebaa0 ffffffff81687073Mar 26 20:55:03 host1 kernel: ffff88103c7ebad8 ffffffff81085cb0 ffffea0000687620 ffffea0000687600Mar 26 20:55:03 host1 kernel: ffff88004a71daf8 ffff88103c7ebda0 ffffea0000687600 ffff88103c7ebae8Mar 26 20:55:03 host1 kernel: Call Trace:Mar 26 20:55:03 host1 kernel: [<ffffffff81687073>] dump_stack+0x19/0x1bMar 26 20:55:03 host1 kernel: [<ffffffff81085cb0>] warn_slowpath_common+0x70/0xb0Mar 26 20:55:03 host1 kernel: [<ffffffff81085dfa>] warn_slowpath_null+0x1a/0x20Mar 26 20:55:03 host1 kernel: [<ffffffffa038bfdb>] xfs_vm_releasepage+0xcb/0x100 [xfs]Mar 26 20:55:03 host1 kernel: [<ffffffff81180b22>] try_to_release_page+0x32/0x50Mar 26 20:55:03 host1 kernel: [<ffffffff81196ad6>] shrink_active_list+0x3d6/0x3e0Mar 26 20:55:03 host1 kernel: [<ffffffff81196ed1>] shrink_lruvec+0x3f1/0x770Mar 26 20:55:03 host1 kernel: [<ffffffff811972c6>] shrink_zone+0x76/0x1a0Mar 26 20:55:03 host1 kernel: [<ffffffff8119857c>] balance_pgdat+0x48c/0x5e0Mar 26 20:55:03 host1 kernel: [<ffffffff81198843>] kswapd+0x173/0x450Mar 26 20:55:03 host1 kernel: [<ffffffff810b1b20>] ? wake_up_atomic_t+0x30/0x30Mar 26 20:55:03 host1 kernel: [<ffffffff811986d0>] ? balance_pgdat+0x5e0/0x5e0Mar 26 20:55:03 host1 kernel: [<ffffffff810b0a4f>] kthread+0xcf/0xe0Mar 26 20:55:03 host1 kernel: [<ffffffff810b0980>] ? kthread_create_on_node+0x140/0x140Mar 26 20:55:03 host1 kernel: [<ffffffff81697698>] ret_from_fork+0x58/0x90Mar 26 20:55:03 host1 kernel: [<ffffffff810b0980>] ? kthread_create_on_node+0x140/0x140Mar 26 20:55:03 host1 kernel: ---[ end trace 24823c5c7a1ea2be ]---

这几台机器的 kernel 及应用程序等崩溃信息由 abrtd 服务接管, 可以通过 abrt-cli 查看概要信息:

# abrt-cli list --since 1547518209id 2181dce8f72761585cb6a904dbff1806c1315c27reason: WARNING: at fs/xfs/xfs_aops.c:1045 xfs_vm_releasepage+0xcb/0x100 [xfs]()time: Sat 23 Mar 2019 08:30:45 PM CSTcmdline: BOOT_IMAGE=/boot/vmlinuz-3.10.0-514.16.1.el7.x86_64 root=/dev/sda1 ro crashkernel=auto net.ifnames=0 biosdevname=0package: kerneluid: 0 (root)count: 1Directory: /var/spool/abrt/oops-2019-03-23-20:30:45-163925-0

内核版本如下:

Centos7
Linux host1 3.10.0-514.21.2.el7.x86_64

分析处理

红帽知识库

参考红帽知识库文档, xfs 的这类警告信息在 xfs 模块遍历代码路径的时候会打印该信息, 不影响主机使用. 可升级内核到 kernel-3.10.0-693.el7 版本避免该警告信息, 详细参见: redhat-access-2893711

Root Cause:

The messages were informational and they do not affect the system in a negative manner. They are seen because the XFS module is traversing through XFS code path.

代码分析

红帽知识库中并未提到内存回收的相关信息, 不过从堆栈信息来看, 像是因为内核回收内存而引起的, 查看对应时间点的内存使用情况如下所示:

04:30:01 PM kbmemfree kbmemused %memused kbbuffers kbcached kbcommit %commit kbactive kbinact kbdirty......08:40:01 PM 513940 130976220 99.61 876 104616380 28610584 21.76 92439660 34840920 52408:50:01 PM 479896 131010264 99.64 876 104666496 28557292 21.72 92513872 34804240 40009:00:01 PM 455948 131034212 99.65 876 104675712 28588852 21.74 92418724 34926132 57209:10:01 PM 556980 130933180 99.58 876 104610352 28552656 21.71 94287212 32983892 900# sysctl vm.min_free_kbytesvm.min_free_kbytes = 90112

20:50 到 21:00 之间的可用内存并没有增加, 这意味着系统可能没有做内存回收操作, 我们按照 kernel 日志的堆栈信息来看函数的调用关系:

shrink_active_list -> try_to_release_page -> xfs_vm_releasepage//source/mm/filemap.c3225 int try_to_release_page(struct page *page, gfp_t gfp_mask)3226 {3227 struct address_space * const mapping = page->mapping;......3233 if (mapping && mapping->a_ops->releasepage)3234 return mapping->a_ops->releasepage(page, gfp_mask); xfs_vm_releasepage3235 return try_to_free_buffers(page);3236 }//source/fs/xfs/xfs_aops.c1034 STATIC int1035 xfs_vm_releasepage(1036 struct page *page,1037 gfp_t gfp_mask)1038 {1039 int delalloc, unwritten;1040 1041 trace_xfs_releasepage(page->mapping->host, page, 0, 0);1042 1043 xfs_count_page_state(page, &delalloc, &unwritten);1044 1045 if (WARN_ON_ONCE(delalloc))1046 return 0;1047 if (WARN_ON_ONCE(unwritten))1048 return 0;1049 1050 return try_to_free_buffers(page);1051 }......1827 const struct address_space_operations xfs_address_space_operations = {1833 .releasepage = xfs_vm_releasepage,

对应 kernel 日志 kernel: WARNING: at fs/xfs/xfs_aops.c:1045 即可看出源文件 source/fs/xfs/xfs_aops.c 的 1045 行打印出了该堆栈信息, 实际上并没有执行 try_to_free_buffers 就已经返回:

1045 if (WARN_ON_ONCE(delalloc))1046 return 0;

WARN_ON_ONCE 则相对简单, 在源文件 source/include/asm-generic/bug.h 即可找到:

73 #define __WARN() warn_slowpath_null(__FILE__, __LINE__)85 #define WARN_ON(condition) ({ \...88 __WARN(); \136 #define WARN_ON_ONCE(condition) ({ \....140 if (unlikely(__ret_warn_once)) \141 if (WARN_ON(!__warned)) \

__WARN 函数则调用了堆栈信息里的 warn_slowpath_null 函数, 进而调用 warn_slowpath_common 函数打印了堆栈信息:

//source/kernel/panic.c517 void warn_slowpath_null(const char *file, int line)518 {519 warn_slowpath_common(file, line, __builtin_return_address(0),520 TAINT_WARN, NULL);521 }463 static void warn_slowpath_common(const char *file, int line, void *caller,464 unsigned taint, struct slowpath_args *args)465 {466 disable_trace_on_warning();467 468 printk(KERN_WARNING "------------[ cut here ]------------\n");469 printk(KERN_WARNING "WARNING: at %s:%d %pS()\n", file, line, caller);470 471 if (args)472 vprintk(args->fmt, args->args);......485 print_modules();486 dump_stack();487 print_oops_end_marker();

我们大致可以看出这个堆栈信息只是警告, 和红帽知识库中描述的一致, 并不影响主机的使用.

总结说明

从上面源文件的函数来看, 只要 kswapd 内存回收的时候调用了 xfs_vm_releasepage 就有可能打印堆栈信息, 如果打印堆栈则不会执行 try_to_free_buffers 操作, 所以查看内存使用的时候可用内存并没有增加. 如果不希望出现堆栈信息可以开启 disable_trace_on_warning 函数对应的 kernel.traceoff_on_warning 内核参数关闭堆栈提示, 不过关闭后其他的内核信息也就不会再打印, 所以从这方面来看只有升级内核版本才会避免出现这个信息.

好了，以上就是这篇文章的全部内容了，希望本文的内容对大家的学习或者工作具有一定的参考学习价值，谢谢大家对的支持。