************************ crashinfo ************************* /exports/testreports/42551/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg439-client-vmcore (3.10.0-7.9-debug) +==========================+ | *** Crashinfo v1.3.7 *** | +==========================+ +++WARNING+++ PARTIAL DUMP with size(vmcore) < 25% size(RAM) KERNEL: /tmp/crash-anaysis.DumBM/vmlinux [TAINTED] DUMPFILE: /exports/testreports/42551/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg439-client-vmcore [PARTIAL DUMP] CPUS: 4 DATE: Wed May 8 18:02:46 EDT 2024 UPTIME: 00:01:58 LOAD AVERAGE: 0.38, 0.15, 0.06 TASKS: 1023 NODENAME: oleg439-client.virtnet RELEASE: 3.10.0-7.9-debug VERSION: #1 SMP Sat Mar 26 23:28:42 EDT 2022 MACHINE: x86_64 (2399 Mhz) MEMORY: 4 GB PANIC: "kernel BUG at mm/truncate.c:156!" +--------------------------+ >------------------------| Per-cpu Stacks ('bt -a') |------------------------< +--------------------------+ -- CPU#0 -- PID=9901 CPU=0 CMD=dir_create.sh #0 crash_nmi_callback+0x31 #1 nmi_handle+0x97 #2 do_nmi+0x12c #3 end_repeat_nmi+0x1e, 538 bytes of data #4 sys_clone+0x0 #5 stub_clone+0x44 #6 system_call_fastpath+0x1f, 477 bytes of data -- CPU#1 -- PID=11558 CPU=1 CMD=ldlm_bl_10 #0 machine_kexec+0x19e #1 __crash_kexec+0x72 #2 crash_kexec+0x30 #3 oops_end+0xa8 #4 die+0x4b #5 do_trap+0x60 #6 do_invalid_op+0xb4 #7 invalid_op+0x1e #-1 do_invalidatepage_range+0x73, 477 bytes of data #8 truncate_inode_pages_range+0x73f #9 check_and_discard_cb+0x269 #10 osc_page_gang_lookup+0x20f #11 osc_lock_discard_pages+0x16a #12 osc_ldlm_blocking_ast+0x35d #13 ldlm_cancel_callback+0x84 #14 ldlm_cli_cancel_local+0xb2 #15 ldlm_cli_cancel+0xd1 #16 osc_ldlm_blocking_ast+0x18a #17 ldlm_handle_bl_callback+0xc5 #18 ldlm_bl_thread_main+0x5fc #19 kthread+0xe4 #20 ret_from_fork_nospec_begin+0x7 -- CPU#2 -- PID=11738 CPU=2 CMD=true #0 crash_nmi_callback+0x31 #1 nmi_handle+0x97 #2 do_nmi+0x12c #3 end_repeat_nmi+0x1e #-1 do_raw_spin_lock+0xc, 507 bytes of data #4 do_raw_spin_lock+0xc #5 _raw_spin_lock_irqsave+0x30 #6 debug_check_no_obj_freed+0xfa #7 kfree+0xa8 #8 __free_fdtable+0x27 #9 put_files_struct+0xfd #10 exit_files+0x47 #11 do_exit+0x2d3 #12 do_group_exit+0x3f #13 sys_exit_group+0x14 #14 system_call_fastpath+0x1f, 477 bytes of data -- CPU#3 -- PID=11756 CPU=3 CMD=dir_remote.sh #0 crash_nmi_callback+0x31 #1 nmi_handle+0x97 #2 do_nmi+0x12c #3 end_repeat_nmi+0x1e, 545 bytes of data #4 async_page_fault+0x0, 510 bytes of data +--------------------------------+ >---------------------| How This Dump Has Been Created |---------------------< +--------------------------------+ *** Dump was triggered by kernel *** BUG: 73 of 73 active objects replaced +---------------+ >------------------------------| Tasks Summary |------------------------------< +---------------+ Number of Threads That Ran Recently ----------------------------------- last second 780 last 5s 904 last 60s 921 ----- Total Numbers of Threads per State ------ TASK_INTERRUPTIBLE 619 TASK_PARKED 3 TASK_RUNNING 51 TASK_UNINTERRUPTIBLE 329 TASK_UNINTERRUPTIBLE|TASK_DEAD 18 +++WARNING+++ There are 3 threads running in their own namespaces Use 'taskinfo --ns' to get more details +-----------------------+ >--------------------------| 5 Most Recent Threads |--------------------------< +-----------------------+ PID CMD Age ARGS ----- -------------- ------ ---------------------------- 9901 dir_create.sh 0 ms (no user stack) 11756 dir_remote.sh 0 ms (no user stack) 11738 true 0 ms (no user stack) 11765 file_create.sh 0 ms (no user stack) 11735 getfattr 0 ms (no user stack) +------------------------+ >-------------------------| Memory Usage (kmem -i) |-------------------------< +------------------------+ PAGES TOTAL PERCENTAGE TOTAL MEM 955079 3.6 GB ---- FREE 775091 3 GB 81% of TOTAL MEM USED 179988 703.1 MB 18% of TOTAL MEM SHARED 18002 70.3 MB 1% of TOTAL MEM BUFFERS 5147 20.1 MB 0% of TOTAL MEM CACHED 50777 198.3 MB 5% of TOTAL MEM SLAB 18779 73.4 MB 1% of TOTAL MEM TOTAL HUGE 0 0 ---- HUGE FREE 0 0 0% of TOTAL HUGE TOTAL SWAP 262143 1024 MB ---- SWAP USED 0 0 0% of TOTAL SWAP SWAP FREE 262143 1024 MB 100% of TOTAL SWAP COMMIT LIMIT 739682 2.8 GB ---- COMMITTED 171035 668.1 MB 23% of TOTAL LIMIT +-------------------------------+ >----------------------| Scheduler Runqueues (per CPU) |----------------------< +-------------------------------+ ---+ CPU=0 ---- | CURRENT TASK , CMD=dir_create.sh 11773 file_rm.sh 0.00000 11776 file_getxattr.s 0.00000 11775 file_chmod.sh 0.00000 11774 file_getxattr.s 0.00000 11752 chown 0.00114 11782 file_getxattr.s 0.00000 11780 file_truncate.s 0.00000 11781 file_mknod.sh 0.00000 11783 file_rename.sh 0.00000 ---+ CPU=1 ---- | CURRENT TASK , CMD=ldlm_bl_10 9706 file_symlink.sh 0.00661 10735 file_setxattr.s 0.00437 11154 mkdir 0.00228 46 kworker/1:1 0.03549 11445 lfs 0.00353 10117 file_chmod.sh 0.00465 5357 ldlm_cb00_001 0.00257 5356 ldlm_cb00_000 0.00389 11629 touch 0.00222 11632 lfs 0.00214 11646 truncate 0.00149 11657 file_setxattr.s 0.00000 11656 file_truncate.s 0.00000 11658 file_chown.sh 0.00000 11764 kthreadd 0.00000 11737 file_chown.sh 0.00000 ---+ CPU=2 ---- | CURRENT TASK , CMD=true 11765 file_create.sh 0.00020 11747 file_list.sh 0.00000 11746 dir_migrate.sh 0.00000 11754 file_chmod.sh 0.00000 11750 setfattr 0.00123 11755 file_fallocate. 0.00000 11728 touch 0.00182 11757 file_symlink.sh 0.00000 11761 dir_remote.sh 0.00000 11769 file_concat.sh 0.00000 11772 file_link.sh 0.00000 11766 file_mknod.sh 0.00000 11784 file_mknod.sh 0.00000 ---+ CPU=3 ---- | CURRENT TASK , CMD=dir_remote.sh 11767 file_setxattr.s 0.00019 11736 ln 0.00164 11734 chown 0.00222 11770 file_exec.sh 0.00000 11771 file_symlink.sh 0.00000 11777 dir_create.sh 0.00000 11778 file_fallocate. 0.00000 11779 file_truncate.s 0.00000 +------------------------+ >-------------------------| Network Status Summary |-------------------------< +------------------------+ TCP Connection Info ------------------- ESTABLISHED 6 TIME_WAIT 144 LISTEN 3 NAGLE disabled (TCP_NODELAY): 5 user_data set (NFS etc.): 4 UDP Connection Info ------------------- 2 UDP sockets, 0 in ESTABLISHED Unix Connection Info ------------------------ ESTABLISHED 26 CLOSE 18 LISTEN 8 Raw sockets info -------------------- ESTABLISHED 1 Interfaces Info --------------- How long ago (in seconds) interfaces transmitted/received? Name RX TX ---- ---------- --------- lo n/a 116.5 eth0 n/a 0.0 RSS_TOTAL=1053612 pages, %mem= 3.0 +------------+ >-------------------------------| Mounted FS |-------------------------------< +------------+ MOUNT SUPERBLK TYPE DEVNAME DIRNAME ffff880138cca000 ffff880139940800 rootfs rootfs / ffff88012aafc000 ffff88012ab00000 sysfs sysfs /sys ffff88012aafc1c0 ffff880139944000 proc proc /proc ffff88012aafc380 ffff880137678000 devtmpfs devtmpfs /dev ffff88012aafc540 ffff8800b6d09000 securityfs securityfs /sys/kernel/security ffff88012aafc700 ffff88012ab00800 tmpfs tmpfs /dev/shm ffff88012aafc8c0 ffff88013771f800 devpts devpts /dev/pts ffff88012aafca80 ffff88012ab01000 tmpfs tmpfs /run ffff88012aafcc40 ffff88012ab01800 tmpfs tmpfs /sys/fs/cgroup ffff88012aafce00 ffff88012ab02000 cgroup cgroup /sys/fs/cgroup/systemd ffff88012aafcfc0 ffff88012ab02800 pstore pstore /sys/fs/pstore ffff88012aafd180 ffff88012ab04800 cgroup cgroup /sys/fs/cgroup/blkio ffff88012aafd340 ffff88012ab04000 cgroup cgroup /sys/fs/cgroup/devices ffff88012aafd500 ffff88012ab03800 cgroup cgroup /sys/fs/cgroup/perf_event ffff88012aafd6c0 ffff88012ab03000 cgroup cgroup /sys/fs/cgroup/net_cls,net_prio ffff88012aafd880 ffff88012ab05000 cgroup cgroup /sys/fs/cgroup/cpu,cpuacct ffff88012aafda40 ffff88012ab05800 cgroup cgroup /sys/fs/cgroup/pids ffff88012aafdc00 ffff88012ab06000 cgroup cgroup /sys/fs/cgroup/hugetlb ffff88012aafddc0 ffff88012ab06800 cgroup cgroup /sys/fs/cgroup/cpuset ffff88012aafe000 ffff88012ab07000 cgroup cgroup /sys/fs/cgroup/freezer ffff88012aafe1c0 ffff88012ab07800 cgroup cgroup /sys/fs/cgroup/memory ffff880137668c40 ffff8800b6d0d000 configfs configfs /sys/kernel/config ffff88012aafe540 ffff88012aba3000 ext4 /dev/nbd0 / ffff88012aafe700 ffff88012aba6800 rpc_pipefs rpc_pipefs /var/lib/nfs/rpc_pipefs ffff88012aafee00 ffff8800b6edd000 autofs systemd-1 /proc/sys/fs/binfmt_misc ffff880137669dc0 ffff8800b620a000 hugetlbfs hugetlbfs /dev/hugepages ffff88012aafefc0 ffff88012b2d8000 mqueue mqueue /dev/mqueue ffff880138ccb180 ffff880139947800 debugfs debugfs /sys/kernel/debug ffff88012aaff180 ffff8800b7c1a800 binfmt_misc binfmt_misc /proc/sys/fs/binfmt_misc/ ffff88012aaff340 ffff8800b6018800 ramfs none /mnt ffff880138ccb340 ffff8800b625f800 tmpfs none /var/lib/stateless/writable ffff88012aaff500 ffff8800b63eb800 squashfs /dev/vda /home/green/git/lustre-release ffff88012aaff6c0 ffff8800b625f800 tmpfs none /var/cache/man ffff8800b617e380 ffff8800b625f800 tmpfs none /var/log ffff8800b617e540 ffff8800b625f800 tmpfs none /var/lib/dbus ffff8800b617e700 ffff8800b625f800 tmpfs none /tmp ffff8800b617e8c0 ffff8800b625f800 tmpfs none /var/lib/dhclient ffff8800b617ea80 ffff8800b625f800 tmpfs none /var/tmp ffff8800b617ec40 ffff8800b625f800 tmpfs none /var/lib/NetworkManager ffff8800b617ee00 ffff8800b625f800 tmpfs none /var/lib/systemd/random-seed ffff8800b617efc0 ffff8800b625f800 tmpfs none /var/spool ffff88012b2ce1c0 ffff8800b625f800 tmpfs none /var/lib/nfs ffff88012aaff880 ffff8800b625f800 tmpfs none /var/lib/gssproxy ffff8800b617f180 ffff8800b625f800 tmpfs none /var/lib/logrotate ffff8800b617f340 ffff8800b625f800 tmpfs none /etc ffff8800b617f500 ffff8800b625f800 tmpfs none /var/lib/rsyslog ffff88012b2ce700 ffff8800b625f800 tmpfs none /var/lib/dhclient/var/lib/dhclient ffff88012aaffa40 ffff88012aba7000 nfs4 192.168.200.253:/exports/state/oleg439-client.virtnet /var/lib/stateless/state ffff88012aaffdc0 ffff88012aba7000 nfs4 192.168.200.253:/exports/state/oleg439-client.virtnet /boot ffff88012aaffc00 ffff88012aba7000 nfs4 192.168.200.253:/exports/state/oleg439-client.virtnet /etc/etc/kdump.conf ffff88012aafec40 ffff88012aba6800 rpc_pipefs sunrpc /var/lib/nfs/var/lib/nfs/rpc_pipefs ffff8800b617fc00 ffff8800b6edc800 nfs4 192.168.200.253://exports/testreports/42551/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64 /tmp/tmp/testlogs ffff88012b2cee00 ffff8800b6eda800 tmpfs tmpfs /run/user/0 ffff8800afc20000 ffff8800b63eb800 squashfs /dev/vda /usr/sbin/mount.lustre ffff8800b5980c40 ffff8800b60ae800 lustre 192.168.204.139@tcp:/lustre /mnt/lustre ffff8800afc20380 ffff880136a97000 lustre 192.168.204.139@tcp:/lustre /mnt/lustre2 +-------------------------------+ >----------------------| Last 40 lines of dmesg buffer |----------------------< +-------------------------------+ [ 119.095672] Modules linked in: lustre(OE) osp(OE) ofd(OE) lod(OE) ost(OE) mdt(OE) mdd(OE) mgs(OE) lquota(OE) lfsck(OE) obdecho(OE) mgc(OE) mdc(OE) lov(OE) osc(OE) lmv(OE) fid(OE) fld(OE) ptlrpc_gss(OE) ptlrpc(OE) obdclass(OE) ksocklnd(OE) lnet(OE) libcfs(OE) crc_t10dif crct10dif_generic rpcsec_gss_krb5 sb_edac edac_core iosf_mbi kvm_intel kvm irqbypass crc32_pclmul ghash_clmulni_intel squashfs aesni_intel lrw gf128mul glue_helper ablk_helper cryptd i2c_piix4 i2c_core pcspkr binfmt_misc ip_tables ext4 mbcache jbd2 ata_generic pata_acpi crct10dif_pclmul crct10dif_common crc32c_intel ata_piix serio_raw libata [ 119.125547] CPU: 1 PID: 11558 Comm: ldlm_bl_10 Kdump: loaded Tainted: G OE ------------ 3.10.0-7.9-debug #1 [ 119.133296] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-1.fc38 04/01/2014 [ 119.137217] task: ffff88012c443330 ti: ffff88009c6e0000 task.ti: ffff88009c6e0000 [ 119.141204] RIP: 0010:[] [] do_invalidatepage_range+0x73/0x80 [ 119.147968] RSP: 0000:ffff88009c6e3880 EFLAGS: 00010283 [ 119.149881] RAX: ffffffffa1061060 RBX: ffffea00027afd40 RCX: 0000000000001000 [ 119.151768] RDX: 0000000000000001 RSI: 0000000000000000 RDI: ffffea00027afd40 [ 119.153644] RBP: ffff88009c6e3880 R08: 00000000ffffffff R09: 0000000000000000 [ 119.156670] R10: 0000000000000001 R11: ffff88009c6e3486 R12: ffffea00028b1980 [ 119.160005] R13: 0000000000000007 R14: ffff88012c443330 R15: ffff88009c6e38b8 [ 119.163058] FS: 0000000000000000(0000) GS:ffff88013e280000(0000) knlGS:0000000000000000 [ 119.167403] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 119.170646] CR2: 00007f861aa59cd4 CR3: 000000012fddc000 CR4: 0000000000160fe0 [ 119.173500] Call Trace: [ 119.174371] [] truncate_inode_pages_range+0x73f/0x7d0 [ 119.177729] [] ? osc_match_base+0x93/0x3b0 [osc] [ 119.181174] [] ? class_handle2object+0xb9/0x200 [obdclass] [ 119.185068] [] check_and_discard_cb+0x269/0x2d0 [osc] [ 119.187567] [] osc_page_gang_lookup+0x20f/0x4e0 [osc] [ 119.191142] [] ? osc_discard_cb+0x2a0/0x2a0 [osc] [ 119.193376] [] osc_lock_discard_pages+0x16a/0x30f [osc] [ 119.196396] [] osc_ldlm_blocking_ast+0x35d/0x670 [osc] [ 119.200370] [] ldlm_cancel_callback+0x84/0x320 [ptlrpc] [ 119.205676] [] ldlm_cli_cancel_local+0xb2/0x460 [ptlrpc] [ 119.208607] [] ldlm_cli_cancel+0xd1/0x6f0 [ptlrpc] [ 119.210317] [] osc_ldlm_blocking_ast+0x18a/0x670 [osc] [ 119.215767] [] ? osc_ldlm_glimpse_ast+0x510/0x510 [osc] [ 119.220284] [] ldlm_handle_bl_callback+0xc5/0x3e0 [ptlrpc] [ 119.224939] [] ldlm_bl_thread_main+0x5fc/0xb40 [ptlrpc] [ 119.229975] [] ? _raw_spin_unlock_irq+0xe/0x30 [ 119.233845] [] ? wake_up_atomic_t+0x30/0x30 [ 119.238423] [] ? ldlm_handle_bl_callback+0x3e0/0x3e0 [ptlrpc] [ 119.242012] [] kthread+0xe4/0xf0 [ 119.244072] [] ? kthread_create_on_node+0x140/0x140 [ 119.246956] [] ret_from_fork_nospec_begin+0x7/0x21 [ 119.251224] [] ? kthread_create_on_node+0x140/0x140 [ 119.254112] Code: f1 0f 1f 80 00 00 00 00 48 8b 40 40 48 85 c0 74 d8 48 85 c0 74 dc 89 f6 b9 00 10 00 00 89 d2 48 29 f1 48 39 ca 75 04 ff d0 5d c3 <0f> 0b 90 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 55 ba 00 [ 119.265822] RIP [] do_invalidatepage_range+0x73/0x80 [ 119.269587] RSP ****************************************************************************** ************************ A Summary Of Problems Found ************************* ****************************************************************************** -------------------- A list of all +++WARNING+++ messages -------------------- PARTIAL DUMP with size(vmcore) < 25% size(RAM) There are 3 threads running in their own namespaces Use 'taskinfo --ns' to get more details ------------------------------------------------------------------------------ ** Execution took 13.52s (real) 8.32s (CPU), Child processes: 5.13s