************************ crashinfo ************************* /exports/testreports/48178/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg356-server-timeout-core (3.10.0-7.9-debug) +==========================+ | *** Crashinfo v1.3.7 *** | +==========================+ +++WARNING+++ PARTIAL DUMP with size(vmcore) < 25% size(RAM) KERNEL: /tmp/crash-anaysis.TYFhA/vmlinux [TAINTED] DUMPFILE: /exports/testreports/48178/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg356-server-timeout-core [PARTIAL DUMP] CPUS: 4 DATE: Tue Dec 24 23:26:23 EST 2024 UPTIME: 00:33:43 LOAD AVERAGE: 0.00, 0.01, 0.23 TASKS: 331 NODENAME: oleg356-server.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: "" +--------------------------+ >------------------------| Per-cpu Stacks ('bt -a') |------------------------< +--------------------------+ -- CPU#0 -- PID=0 CPU=0 CMD=swapper/0 #-1 native_safe_halt+0xb, 449 bytes of data #0 default_idle+0x1e #1 default_enter_idle+0x45 #2 cpuidle_enter_state+0x40 #3 cpuidle_idle_call+0xd8 #4 arch_cpu_idle+0xe #5 cpu_startup_entry+0x14a #6 rest_init+0x8e #7 start_kernel+0x456 #8 x86_64_start_reservations+0x2a #9 x86_64_start_kernel+0x152 #10 start_cpu+0x5 -- CPU#1 -- PID=0 CPU=1 CMD=swapper/1 #-1 native_safe_halt+0xb, 449 bytes of data #0 default_idle+0x1e #1 default_enter_idle+0x45 #2 cpuidle_enter_state+0x40 #3 cpuidle_idle_call+0xd8 #4 arch_cpu_idle+0xe #5 cpu_startup_entry+0x14a #6 start_secondary+0x1eb #7 start_cpu+0x5 -- CPU#2 -- PID=0 CPU=2 CMD=swapper/2 #-1 native_safe_halt+0xb, 449 bytes of data #0 default_idle+0x1e #1 default_enter_idle+0x45 #2 cpuidle_enter_state+0x40 #3 cpuidle_idle_call+0xd8 #4 arch_cpu_idle+0xe #5 cpu_startup_entry+0x14a #6 start_secondary+0x1eb #7 start_cpu+0x5 -- CPU#3 -- PID=0 CPU=3 CMD=swapper/3 #-1 native_safe_halt+0xb, 449 bytes of data #0 default_idle+0x1e #1 default_enter_idle+0x45 #2 cpuidle_enter_state+0x40 #3 cpuidle_idle_call+0xd8 #4 arch_cpu_idle+0xe #5 cpu_startup_entry+0x14a #6 start_secondary+0x1eb #7 start_cpu+0x5 +--------------------------------+ >---------------------| How This Dump Has Been Created |---------------------< +--------------------------------+ Cannot identify the specific condition that triggered vmcore +---------------+ >------------------------------| Tasks Summary |------------------------------< +---------------+ Number of Threads That Ran Recently ----------------------------------- last second 22 last 5s 67 last 60s 82 ----- Total Numbers of Threads per State ------ TASK_INTERRUPTIBLE 327 TASK_RUNNING 1 +++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 ----- -------------- ------ ---------------------------- 4531 dbuf_evict 0 ms (no user stack) 3778 ptlrpcd_00_00 0 ms (no user stack) 4529 arc_reap 0 ms (no user stack) 912 kworker/0:2 0 ms (no user stack) 31 kworker/3:0 0 ms (no user stack) +------------------------+ >-------------------------| Memory Usage (kmem -i) |-------------------------< +------------------------+ PAGES TOTAL PERCENTAGE TOTAL MEM 955067 3.6 GB ---- FREE 673312 2.6 GB 70% of TOTAL MEM USED 281755 1.1 GB 29% of TOTAL MEM SHARED 37452 146.3 MB 3% of TOTAL MEM BUFFERS 35114 137.2 MB 3% of TOTAL MEM CACHED 93496 365.2 MB 9% of TOTAL MEM SLAB 24151 94.3 MB 2% 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 739676 2.8 GB ---- COMMITTED 59062 230.7 MB 7% of TOTAL LIMIT +-------------------------------+ >----------------------| Scheduler Runqueues (per CPU) |----------------------< +-------------------------------+ ---+ CPU=0 ---- | CURRENT TASK , CMD=swapper/0 ---+ CPU=1 ---- | CURRENT TASK , CMD=swapper/1 ---+ CPU=2 ---- | CURRENT TASK , CMD=swapper/2 ---+ CPU=3 ---- | CURRENT TASK , CMD=swapper/3 +------------------------+ >-------------------------| Network Status Summary |-------------------------< +------------------------+ TCP Connection Info ------------------- ESTABLISHED 9 LISTEN 3 NAGLE disabled (TCP_NODELAY): 7 user_data set (NFS etc.): 8 UDP Connection Info ------------------- 2 UDP sockets, 0 in ESTABLISHED Unix Connection Info ------------------------ ESTABLISHED 26 CLOSE 17 LISTEN 8 Raw sockets info -------------------- CLOSE 1 Interfaces Info --------------- How long ago (in seconds) interfaces transmitted/received? Name RX TX ---- ---------- --------- lo n/a 2020.4 eth0 n/a 0.7 RSS_TOTAL=49404 pages, %mem= 0.8 +------------+ >-------------------------------| Mounted FS |-------------------------------< +------------+ MOUNT SUPERBLK TYPE DEVNAME DIRNAME ffff880138cca000 ffff880139940800 rootfs rootfs / ffff88013701d180 ffff88012b28b800 sysfs sysfs /sys ffff88013701d340 ffff880139944000 proc proc /proc ffff88013701d500 ffff880137678000 devtmpfs devtmpfs /dev ffff88013701d6c0 ffff88012b28b000 securityfs securityfs /sys/kernel/security ffff88013701d880 ffff88012b28c000 tmpfs tmpfs /dev/shm ffff88013701da40 ffff88012b288000 devpts devpts /dev/pts ffff88013701dc00 ffff88012b28c800 tmpfs tmpfs /run ffff88013701ddc0 ffff88012b28d000 tmpfs tmpfs /sys/fs/cgroup ffff88012a30e000 ffff88012b28d800 cgroup cgroup /sys/fs/cgroup/systemd ffff88012a30e1c0 ffff88012b28e000 pstore pstore /sys/fs/pstore ffff88012a30e380 ffff88012a2e0000 cgroup cgroup /sys/fs/cgroup/net_cls,net_prio ffff88012a30e540 ffff88012a2e0800 cgroup cgroup /sys/fs/cgroup/cpuset ffff88012a30e700 ffff88012a2e1000 cgroup cgroup /sys/fs/cgroup/cpu,cpuacct ffff88012a30e8c0 ffff88012a2e1800 cgroup cgroup /sys/fs/cgroup/memory ffff88012a30ea80 ffff88012a2e2000 cgroup cgroup /sys/fs/cgroup/perf_event ffff88012a30ec40 ffff88012a2e2800 cgroup cgroup /sys/fs/cgroup/hugetlb ffff88012a30ee00 ffff88012a2e3000 cgroup cgroup /sys/fs/cgroup/freezer ffff88012a30efc0 ffff88012a2e3800 cgroup cgroup /sys/fs/cgroup/devices ffff88012a30f180 ffff88012a2e4000 cgroup cgroup /sys/fs/cgroup/pids ffff88012a30f340 ffff88012a2e4800 cgroup cgroup /sys/fs/cgroup/blkio ffff880137668380 ffff88013767e000 configfs configfs /sys/kernel/config ffff88012a30f880 ffff880129d6e800 ext4 /dev/nbd0 / ffff8801376696c0 ffff88012a2e5000 rpc_pipefs rpc_pipefs /var/lib/nfs/rpc_pipefs ffff88012a30fdc0 ffff8800b4c2d800 autofs systemd-1 /proc/sys/fs/binfmt_misc ffff8800b4d84000 ffff88012b289800 mqueue mqueue /dev/mqueue ffff88012a30fc00 ffff8800b4c2e000 hugetlbfs hugetlbfs /dev/hugepages ffff88012a30fa40 ffff880139947800 debugfs debugfs /sys/kernel/debug ffff880137669880 ffff8800b40ff800 binfmt_misc binfmt_misc /proc/sys/fs/binfmt_misc/ ffff8800b4d841c0 ffff8800b42a3800 ramfs none /mnt ffff880137669c00 ffff8800b40f8800 tmpfs none /var/lib/stateless/writable ffff880137669dc0 ffff8800b40fa800 squashfs /dev/vda /home/green/git/lustre-release ffff880138ccac40 ffff8800b40f8800 tmpfs none /var/cache/man ffff880138ccae00 ffff8800b40f8800 tmpfs none /var/log ffff880129da6000 ffff8800b40f8800 tmpfs none /var/lib/dbus ffff880136ae81c0 ffff8800b40f8800 tmpfs none /tmp ffff880129da61c0 ffff8800b40f8800 tmpfs none /var/lib/dhclient ffff880136ae8380 ffff8800b40f8800 tmpfs none /var/tmp ffff8800b4d84380 ffff8800b40f8800 tmpfs none /var/lib/NetworkManager ffff8800b4d84540 ffff8800b40f8800 tmpfs none /var/lib/systemd/random-seed ffff8800b4d84700 ffff8800b40f8800 tmpfs none /var/spool ffff8800b4d848c0 ffff8800b40f8800 tmpfs none /var/lib/nfs ffff8800b4d84a80 ffff8800b40f8800 tmpfs none /var/lib/gssproxy ffff8800b4d84c40 ffff8800b40f8800 tmpfs none /var/lib/logrotate ffff880129da6380 ffff8800b40f8800 tmpfs none /etc ffff880136ae8540 ffff8800b40f8800 tmpfs none /var/lib/rsyslog ffff880138ccafc0 ffff8800b40f8800 tmpfs none /var/lib/dhclient/var/lib/dhclient ffff880136ae8700 ffff8800b4098800 nfs4 192.168.200.253:/exports/state/oleg356-server.virtnet /var/lib/stateless/state ffff880129da6700 ffff8800b4098800 nfs4 192.168.200.253:/exports/state/oleg356-server.virtnet /boot ffff880138ccb180 ffff8800b4098800 nfs4 192.168.200.253:/exports/state/oleg356-server.virtnet /etc/etc/kdump.conf ffff880136ae8a80 ffff88012a2e5000 rpc_pipefs sunrpc /var/lib/nfs/var/lib/nfs/rpc_pipefs ffff8800b4c48e00 ffff8800b40fa800 squashfs /dev/vda /usr/sbin/mount.lustre ffff8800b4c37dc0 ffff8800b4c2c000 lustre /dev/mapper/mds1_flakey /mnt/lustre-mds1 ffff8800b4c36a80 ffff8800a3821000 lustre /dev/mapper/mds2_flakey /mnt/lustre-mds2 ffff8800b4c37a40 ffff88009d73a800 lustre /dev/mapper/ost1_flakey /mnt/lustre-ost1 ffff8800b4c37880 ffff88009f36b800 lustre /dev/mapper/ost2_flakey /mnt/lustre-ost2 +-------------------------------+ >----------------------| Last 40 lines of dmesg buffer |----------------------< +-------------------------------+ [ 415.238138] Call Trace: [ 415.238941] [] dump_stack+0x19/0x1b [ 415.242174] [] osd_trans_start+0x67e/0x6f0 [osd_ldiskfs] [ 415.246833] [] ? __llog_ctxt_put+0xd3/0x140 [obdclass] [ 415.250333] [] top_trans_start+0x351/0xab0 [ptlrpc] [ 415.254192] [] lod_trans_start+0x7f/0x2e0 [lod] [ 415.256964] [] mdd_trans_start+0x14/0x20 [mdd] [ 415.261095] [] mdd_migrate_object+0x1439/0x1e00 [mdd] [ 415.266159] [] ? sched_feat_set+0xf0/0xf0 [ 415.270152] [] ? __mdt_stripe_get+0xe1/0x4e0 [mdt] [ 415.273057] [] mdd_migrate+0x28/0x30 [mdd] [ 415.277058] [] mdt_reint_migrate+0x1b63/0x23f0 [mdt] [ 415.280961] [] ? lustre_msg_add_version+0x27/0xa0 [ptlrpc] [ 415.288384] [] mdt_reint_rec+0x87/0x240 [mdt] [ 415.291470] [] mdt_reint_internal+0x74c/0xbc0 [mdt] [ 415.295308] [] ? mdt_thread_info_init+0xa5/0xc0 [mdt] [ 415.299229] [] mdt_reint+0x67/0x150 [mdt] [ 415.302925] [] tgt_request_handle+0x74e/0x1a60 [ptlrpc] [ 415.307185] [] ptlrpc_server_handle_request+0x281/0xce0 [ptlrpc] [ 415.312837] [] ptlrpc_main+0xc61/0x1640 [ptlrpc] [ 415.318904] [] ? put_prev_entity+0x31/0x400 [ 415.322991] [] ? do_raw_spin_unlock+0x49/0x90 [ 415.326640] [] ? _raw_spin_unlock_irq+0xe/0x30 [ 415.331007] [] ? ptlrpc_wait_event+0x630/0x630 [ptlrpc] [ 415.334694] [] kthread+0xe4/0xf0 [ 415.336555] [] ? kthread_create_on_node+0x140/0x140 [ 415.343057] [] ret_from_fork_nospec_begin+0x7/0x21 [ 415.345842] [] ? kthread_create_on_node+0x140/0x140 [ 437.227141] Lustre: 16216:0:(osd_internal.h:1330:osd_trans_exec_op()) lustre-MDT0000: opcode 2: before 3196 < left 3325, rollback = 2 [ 437.232918] Lustre: 16216:0:(osd_internal.h:1330:osd_trans_exec_op()) Skipped 206 previous similar messages [ 452.705093] Lustre: 7244:0:(osd_handler.c:1961:osd_trans_dump_creds()) create: 2/8/0, destroy: 1/4/0 [ 452.711645] Lustre: 7244:0:(osd_handler.c:1961:osd_trans_dump_creds()) Skipped 360 previous similar messages [ 452.717088] Lustre: 7244:0:(osd_handler.c:1968:osd_trans_dump_creds()) attr_set: 2/2/0, xattr_set: 38/3297/0 [ 452.720862] Lustre: 7244:0:(osd_handler.c:1968:osd_trans_dump_creds()) Skipped 360 previous similar messages [ 452.726176] Lustre: 7244:0:(osd_handler.c:1978:osd_trans_dump_creds()) write: 1/10/0, punch: 0/0/0, quota 7/105/0 [ 452.731315] Lustre: 7244:0:(osd_handler.c:1978:osd_trans_dump_creds()) Skipped 360 previous similar messages [ 452.734656] Lustre: 7244:0:(osd_handler.c:1985:osd_trans_dump_creds()) insert: 12/194/2, delete: 3/6/0 [ 452.738154] Lustre: 7244:0:(osd_handler.c:1985:osd_trans_dump_creds()) Skipped 360 previous similar messages [ 452.741539] Lustre: 7244:0:(osd_handler.c:1992:osd_trans_dump_creds()) ref_add: 7/7/0, ref_del: 3/3/0 [ 452.744007] Lustre: 7244:0:(osd_handler.c:1992:osd_trans_dump_creds()) Skipped 360 previous similar messages ****************************************************************************** ************************ 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 12.21s (real) 6.55s (CPU), Child processes: 5.61s