************************ crashinfo ************************* /exports/testreports/52062/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg119-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.I4FjG/vmlinux [TAINTED] DUMPFILE: /exports/testreports/52062/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg119-server-timeout-core [PARTIAL DUMP] CPUS: 4 DATE: Wed May 28 18:05:23 EDT 2025 UPTIME: 00:17:01 LOAD AVERAGE: 0.25, 0.48, 0.70 TASKS: 323 NODENAME: oleg119-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 55 last 5s 87 last 60s 99 ----- Total Numbers of Threads per State ------ TASK_INTERRUPTIBLE 319 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 ----- -------------- ------ ---------------------------- 46 kworker/0:1 0 ms (no user stack) 3759 lnet_discovery 0 ms (no user stack) 83 kworker/1:1 0 ms (no user stack) 7211 mdt_out00_000 0 ms (no user stack) 3762 ptlrpcd_00_01 1 ms (no user stack) +------------------------+ >-------------------------| Memory Usage (kmem -i) |-------------------------< +------------------------+ PAGES TOTAL PERCENTAGE TOTAL MEM 955067 3.6 GB ---- FREE 648489 2.5 GB 67% of TOTAL MEM USED 306578 1.2 GB 32% of TOTAL MEM SHARED 45033 175.9 MB 4% of TOTAL MEM BUFFERS 42634 166.5 MB 4% of TOTAL MEM CACHED 108814 425.1 MB 11% of TOTAL MEM SLAB 26679 104.2 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 59046 230.6 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 -------------------- ESTABLISHED 1 Interfaces Info --------------- How long ago (in seconds) interfaces transmitted/received? Name RX TX ---- ---------- --------- lo n/a 1019.4 eth0 n/a 1.4 RSS_TOTAL=53276 pages, %mem= 0.9 +------------+ >-------------------------------| Mounted FS |-------------------------------< +------------+ MOUNT SUPERBLK TYPE DEVNAME DIRNAME ffff880138cca000 ffff880139940800 rootfs rootfs / ffff88012a35e000 ffff8800b5229000 sysfs sysfs /sys ffff88012a35e1c0 ffff880139944000 proc proc /proc ffff88012a35e380 ffff880137678000 devtmpfs devtmpfs /dev ffff88012a35e540 ffff880137679000 securityfs securityfs /sys/kernel/security ffff88012a35e700 ffff8800b5229800 tmpfs tmpfs /dev/shm ffff88012a35e8c0 ffff880137316000 devpts devpts /dev/pts ffff88012a35ea80 ffff8800b522a000 tmpfs tmpfs /run ffff88012a35ec40 ffff8800b522a800 tmpfs tmpfs /sys/fs/cgroup ffff88012a35ee00 ffff8800b522b000 cgroup cgroup /sys/fs/cgroup/systemd ffff88012a35efc0 ffff8800b522b800 pstore pstore /sys/fs/pstore ffff88012a35f180 ffff8800b522d800 cgroup cgroup /sys/fs/cgroup/cpu,cpuacct ffff88012a35f340 ffff8800b522d000 cgroup cgroup /sys/fs/cgroup/net_cls,net_prio ffff88012a35f500 ffff8800b522c800 cgroup cgroup /sys/fs/cgroup/freezer ffff88012a35f6c0 ffff8800b522c000 cgroup cgroup /sys/fs/cgroup/memory ffff88012a35f880 ffff8800b522e000 cgroup cgroup /sys/fs/cgroup/perf_event ffff88012a35fa40 ffff8800b522e800 cgroup cgroup /sys/fs/cgroup/blkio ffff88012a35fc00 ffff8800b522f000 cgroup cgroup /sys/fs/cgroup/pids ffff88012a35fdc0 ffff8800b522f800 cgroup cgroup /sys/fs/cgroup/hugetlb ffff88012a280000 ffff88012a370000 cgroup cgroup /sys/fs/cgroup/devices ffff88012a2801c0 ffff88012a370800 cgroup cgroup /sys/fs/cgroup/cpuset ffff88012a280380 ffff88012a377000 configfs configfs /sys/kernel/config ffff8801376688c0 ffff88013767e000 ext4 /dev/nbd0 / ffff88012a280540 ffff88012ae24800 rpc_pipefs rpc_pipefs /var/lib/nfs/rpc_pipefs ffff88012b266e00 ffff8800b41fe000 autofs systemd-1 /proc/sys/fs/binfmt_misc ffff88012a280700 ffff880137317800 mqueue mqueue /dev/mqueue ffff880137668c40 ffff880139947800 debugfs debugfs /sys/kernel/debug ffff88012b266fc0 ffff8800b41fe800 hugetlbfs hugetlbfs /dev/hugepages ffff88012b267180 ffff88013767a000 binfmt_misc binfmt_misc /proc/sys/fs/binfmt_misc/ ffff88012b267340 ffff880137679800 ramfs none /mnt ffff88012a280a80 ffff880129819000 tmpfs none /var/lib/stateless/writable ffff8800b251c000 ffff8800b41fa800 squashfs /dev/vda /home/green/git/lustre-release ffff880137668a80 ffff880129819000 tmpfs none /var/cache/man ffff88012a280c40 ffff880129819000 tmpfs none /var/log ffff88012a280e00 ffff880129819000 tmpfs none /var/lib/dbus ffff88012a280fc0 ffff880129819000 tmpfs none /tmp ffff88012a281180 ffff880129819000 tmpfs none /var/lib/dhclient ffff880137668fc0 ffff880129819000 tmpfs none /var/tmp ffff880137669180 ffff880129819000 tmpfs none /var/lib/NetworkManager ffff880137669340 ffff880129819000 tmpfs none /var/lib/systemd/random-seed ffff88012b267500 ffff880129819000 tmpfs none /var/spool ffff880137669500 ffff880129819000 tmpfs none /var/lib/nfs ffff88012b2676c0 ffff880129819000 tmpfs none /var/lib/gssproxy ffff88012a281340 ffff880129819000 tmpfs none /var/lib/logrotate ffff88012b267880 ffff880129819000 tmpfs none /etc ffff88012a281500 ffff880129819000 tmpfs none /var/lib/rsyslog ffff88012a2816c0 ffff880129819000 tmpfs none /var/lib/dhclient/var/lib/dhclient ffff88012a281880 ffff8800b5316000 nfs4 192.168.200.253:/exports/state/oleg119-server.virtnet /var/lib/stateless/state ffff88012a281dc0 ffff8800b5316000 nfs4 192.168.200.253:/exports/state/oleg119-server.virtnet /boot ffff88012b267a40 ffff8800b5316000 nfs4 192.168.200.253:/exports/state/oleg119-server.virtnet /etc/etc/kdump.conf ffff8801376696c0 ffff88012ae24800 rpc_pipefs sunrpc /var/lib/nfs/var/lib/nfs/rpc_pipefs ffff8800aeb27500 ffff8800b41fa800 squashfs /dev/vda /usr/sbin/mount.lustre ffff8800ae8596c0 ffff880129e77800 lustre /dev/mapper/mds1_flakey /mnt/lustre-mds1 ffff8800ae858380 ffff8800ad010000 lustre /dev/mapper/mds2_flakey /mnt/lustre-mds2 ffff8800ae859180 ffff8800aebc2000 lustre /dev/mapper/ost1_flakey /mnt/lustre-ost1 ffff8800ae859880 ffff88007fc18000 lustre /dev/mapper/ost2_flakey /mnt/lustre-ost2 +-------------------------------+ >----------------------| Last 40 lines of dmesg buffer |----------------------< +-------------------------------+ [ 377.232477] CPU: 3 PID: 16167 Comm: mdt_io00_009 Kdump: loaded Tainted: P OE ------------ 3.10.0-7.9-debug #1 [ 377.235495] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.3-2.fc40 04/01/2014 [ 377.238603] Call Trace: [ 377.239201] [] dump_stack+0x19/0x1b [ 377.241018] [] osd_trans_start+0x683/0x6b0 [osd_ldiskfs] [ 377.243798] [] ? __llog_ctxt_put+0xd3/0x140 [obdclass] [ 377.246610] [] top_trans_start+0x351/0xab0 [ptlrpc] [ 377.248517] [] lod_trans_start+0x7f/0x2e0 [lod] [ 377.250203] [] mdd_trans_start+0x14/0x20 [mdd] [ 377.251818] [] mdd_migrate_object+0x12ee/0x2470 [mdd] [ 377.253548] [] ? do_raw_spin_unlock+0x49/0x90 [ 377.255002] [] ? __wake_up_common_lock+0x91/0xc0 [ 377.256822] [] ? __mdt_stripe_get+0xe1/0x4e0 [mdt] [ 377.259302] [] mdd_migrate+0x28/0x30 [mdd] [ 377.261489] [] mdt_reint_migrate+0x1b9f/0x24b0 [mdt] [ 377.263246] [] ? lustre_msg_add_version+0x27/0xa0 [ptlrpc] [ 377.265542] [] mdt_reint_rec+0x87/0x240 [mdt] [ 377.267661] [] mdt_reint_internal+0x73c/0xbb0 [mdt] [ 377.270352] [] ? mdt_thread_info_init+0xa5/0xc0 [mdt] [ 377.272527] [] mdt_reint+0x67/0x150 [mdt] [ 377.274541] [] tgt_request_handle+0x74e/0x1a60 [ptlrpc] [ 377.276924] [] ptlrpc_server_handle_request+0x257/0xcd0 [ptlrpc] [ 377.279703] [] ptlrpc_main+0xc61/0x1640 [ptlrpc] [ 377.281753] [] ? do_raw_spin_unlock+0x49/0x90 [ 377.284232] [] ? _raw_spin_unlock_irq+0xe/0x30 [ 377.286618] [] ? ptlrpc_wait_event+0x630/0x630 [ptlrpc] [ 377.289176] [] kthread+0xe4/0xf0 [ 377.290765] [] ? kthread_create_on_node+0x140/0x140 [ 377.293532] [] ret_from_fork_nospec_begin+0x7/0x21 [ 377.296224] [] ? kthread_create_on_node+0x140/0x140 [ 378.798137] LustreError: 16155:0:(mdd_dir.c:4743:mdd_migrate_cmd_check()) lustre-MDD0001: '10' migration was interrupted, run 'lfs migrate -m 0 -c 2 -H crush 10' to finish migration: rc = -1 [ 378.801911] LustreError: 16155:0:(mdd_dir.c:4743:mdd_migrate_cmd_check()) Skipped 32 previous similar messages [ 381.028409] LustreError: 16132:0:(mdt_xattr.c:402:mdt_dir_layout_update()) lustre-MDT0000: [0x200000403:0x444a:0x0] migrate mdt count mismatch 2 != 1 [ 381.031966] LustreError: 16132:0:(mdt_xattr.c:402:mdt_dir_layout_update()) Skipped 2 previous similar messages [ 381.696213] Lustre: 16166:0:(osd_internal.h:1332:osd_trans_exec_op()) lustre-MDT0001: opcode 2: before 3197 < left 3414, rollback = 2 [ 381.701697] Lustre: 16166:0:(osd_internal.h:1332:osd_trans_exec_op()) Skipped 104 previous similar messages [ 413.959787] LustreError: 7210:0:(mdd_object.c:3901:mdd_close()) lustre-MDD0001: failed to get lu_attr of [0x240000402:0x40e5:0x0]: rc = -2 [ 413.962857] LustreError: 7210:0:(mdd_object.c:3901:mdd_close()) Skipped 6 previous similar messages [ 489.397900] LustreError: 7198:0:(ldlm_lockd.c:257:expired_lock_main()) ### lock callback timer expired after 100s: evicting client at 192.168.201.19@tcp ns: mdt-lustre-MDT0001_UUID lock: ffff88011d9b7a00/0x6ec47bca07f7b702 lrc: 3/0,0 mode: PR/PR res: [0x240000404:0x3bcb:0x0].0x0 bits 0x1b/0x0 rrc: 4 type: IBT gid 0 flags: 0x60200400000020 nid: 192.168.201.19@tcp remote: 0xa3ca9afd79727eb9 expref: 1943 pid: 16132 timeout: 488 lvb_type: 0 [ 489.446323] LustreError: 7194:0:(ldlm_lockd.c:2550:ldlm_cancel_handler()) ldlm_cancel from 192.168.201.19@tcp arrived at 1748469391 with bad export cookie 7981640547244288952 ****************************************************************************** ************************ 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 11.51s (real) 6.28s (CPU), Child processes: 5.19s