************************ crashinfo ************************* /exports/testreports/50430/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg133-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.aJCiy/vmlinux [TAINTED] DUMPFILE: /exports/testreports/50430/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64/oleg133-client-vmcore [PARTIAL DUMP] CPUS: 4 DATE: Tue Apr 1 13:16:29 EDT 2025 UPTIME: 00:03:02 LOAD AVERAGE: 175.95, 43.81, 14.65 TASKS: 1024 NODENAME: oleg133-client.virtnet RELEASE: 3.10.0-7.9-debug VERSION: #1 SMP Sat Mar 26 23:28:42 EDT 2022 MACHINE: x86_64 (2400 Mhz) MEMORY: 4 GB PANIC: "BUG: unable to handle kernel NULL pointer dereference at 000000000000012e" +--------------------------+ >------------------------| Per-cpu Stacks ('bt -a') |------------------------< +--------------------------+ -- CPU#0 -- PID=0 CPU=0 CMD=swapper/0 #0 crash_nmi_callback+0x31 #1 nmi_handle+0x97 #2 do_nmi+0x12c #3 end_repeat_nmi+0x1e #-1 native_safe_halt+0xb, 507 bytes of data #4 native_safe_halt+0xb #5 default_idle+0x1e #6 default_enter_idle+0x45 #7 cpuidle_enter_state+0x40 #8 cpuidle_idle_call+0xd8 #9 arch_cpu_idle+0xe #10 cpu_startup_entry+0x14a #11 rest_init+0x8e #12 start_kernel+0x456 #13 x86_64_start_reservations+0x2a #14 x86_64_start_kernel+0x152 #15 start_cpu+0x5 -- CPU#1 -- PID=22427 CPU=1 CMD=lfs #0 machine_kexec+0x19e #1 __crash_kexec+0x72 #2 crash_kexec+0x30 #3 oops_end+0xa8 #4 no_context+0x144 #5 __bad_area_nosemaphore+0x112 #6 bad_area+0x49 #7 __do_page_fault+0x494 #8 trace_do_page_fault+0x56 #9 do_async_page_fault+0x22 #10 async_page_fault+0x28 #-1 osc_io_submit+0x142, 477 bytes of data #11 cl_io_submit_rw+0x72 #12 lov_io_submit+0x1b4 #13 cl_io_submit_rw+0x72 #14 ll_direct_IO_impl+0x530 #15 ll_direct_IO+0x7c #16 generic_file_aio_read+0x24e #17 vvp_io_read_start+0x779 #18 cl_io_start+0x6d #19 cl_io_loop+0x9f #20 ll_file_io_generic+0x36b #21 do_file_read_iter+0xc46 #22 ll_file_read_iter+0x2d #23 ll_file_aio_read+0x1b1 #24 ll_file_read+0x111 #25 vfs_read+0xb9 #26 sys_pread64+0x92 #27 system_call_fastpath+0x1f, 477 bytes of data -- CPU#2 -- PID=0 CPU=2 CMD=swapper/2 #0 crash_nmi_callback+0x31 #1 nmi_handle+0x97 #2 do_nmi+0x12c #3 end_repeat_nmi+0x1e #-1 native_safe_halt+0xb, 507 bytes of data #4 native_safe_halt+0xb #5 default_idle+0x1e #6 default_enter_idle+0x45 #7 cpuidle_enter_state+0x40 #8 cpuidle_idle_call+0xd8 #9 arch_cpu_idle+0xe #10 cpu_startup_entry+0x14a #11 start_secondary+0x1eb #12 start_cpu+0x5 -- CPU#3 -- PID=23377 CPU=3 CMD=file_create.sh #0 crash_nmi_callback+0x31 #1 nmi_handle+0x97 #2 do_nmi+0x12c #3 end_repeat_nmi+0x1e #-1 migrate_task_rq_fair+0x22, 507 bytes of data #4 migrate_task_rq_fair+0x22 #5 set_task_cpu+0x60 #6 try_to_wake_up+0xfd #7 wake_up_process+0x15 #8 process_timeout+0xe #9 call_timer_fn+0x36 #10 run_timer_softirq+0x264 #11 __do_softirq+0xf7 #12 call_softirq+0x1c #13 do_softirq+0x65 #14 irq_exit+0x105 #15 smp_apic_timer_interrupt+0x42 #16 apic_timer_interrupt+0x16a, 19 bytes of data #17 apic_timer_interrupt+0x16a #-1 filemap_fault+0x19e, 477 bytes of data #18 ext4_filemap_fault+0x36 #19 __do_fault+0x84 #20 do_read_fault+0x50 #21 handle_pte_fault+0x2ef #22 __handle_mm_fault+0x31d #23 handle_mm_fault+0xc2 #24 __do_page_fault+0x1a0 #25 trace_do_page_fault+0x56 #26 do_async_page_fault+0x22 #27 async_page_fault+0x28, 477 bytes of data +--------------------------------+ >---------------------| How This Dump Has Been Created |---------------------< +--------------------------------+ *** Dump was triggered by kernel *** BUG: 73 of 73 active objects replaced +++WARNING+++ High Load Averages: 175.95, 43.81, 14.65 +---------------+ >------------------------------| Tasks Summary |------------------------------< +---------------+ Number of Threads That Ran Recently ----------------------------------- last second 448 last 5s 580 last 60s 943 ----- Total Numbers of Threads per State ------ TASK_INTERRUPTIBLE 593 TASK_RUNNING 4 TASK_UNINTERRUPTIBLE 384 TASK_UNINTERRUPTIBLE|TASK_DEAD 39 TASK_WAKEKILL 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 ----- -------------- ------ ---------------------------- 23378 dir_remote.sh 0 ms (no user stack) 23371 file_chmod.sh 0 ms (no user stack) 2010 socknal_sd00_01 0 ms (no user stack) 9727 file_list.sh 0 ms (no user stack) 2009 socknal_sd00_00 0 ms (no user stack) +------------------------+ >-------------------------| Memory Usage (kmem -i) |-------------------------< +------------------------+ PAGES TOTAL PERCENTAGE TOTAL MEM 955079 3.6 GB ---- FREE 762551 2.9 GB 79% of TOTAL MEM USED 192528 752.1 MB 20% of TOTAL MEM SHARED 28877 112.8 MB 3% of TOTAL MEM BUFFERS 5163 20.2 MB 0% of TOTAL MEM CACHED 62815 245.4 MB 6% of TOTAL MEM SLAB 20322 79.4 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 739682 2.8 GB ---- COMMITTED 188418 736 MB 25% of TOTAL LIMIT +++WARNING+++ Panic while we were doing sync on FS +-------------------------------+ >----------------------| Scheduler Runqueues (per CPU) |----------------------< +-------------------------------+ ---+ CPU=0 ---- | CURRENT TASK , CMD=swapper/0 ---+ CPU=1 ---- | CURRENT TASK , CMD=lfs ---+ CPU=2 ---- | CURRENT TASK , CMD=swapper/2 ---+ CPU=3 ---- | CURRENT TASK , CMD=file_create.sh +------------------------+ >-------------------------| Network Status Summary |-------------------------< +------------------------+ TCP Connection Info ------------------- ESTABLISHED 6 TIME_WAIT 42 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 179.2 eth0 n/a 0.0 RSS_TOTAL=1075824 pages, %mem= 3.0 +------------+ >-------------------------------| Mounted FS |-------------------------------< +------------+ MOUNT SUPERBLK TYPE DEVNAME DIRNAME ffff880138cca000 ffff880139940800 rootfs rootfs / ffff88012aa6e000 ffff8800b7c25000 sysfs sysfs /sys ffff88012aa6e1c0 ffff880139944000 proc proc /proc ffff88012aa6e380 ffff880137678000 devtmpfs devtmpfs /dev ffff88012aa6e540 ffff8800b6d00800 securityfs securityfs /sys/kernel/security ffff88012aa6e700 ffff8800b7c25800 tmpfs tmpfs /dev/shm ffff88012aa6e8c0 ffff88013731e800 devpts devpts /dev/pts ffff88012aa6ea80 ffff8800b7c26000 tmpfs tmpfs /run ffff88012aa6ec40 ffff8800b7c26800 tmpfs tmpfs /sys/fs/cgroup ffff88012aa6ee00 ffff8800b7c27000 cgroup cgroup /sys/fs/cgroup/systemd ffff88012aa6efc0 ffff8800b7c27800 pstore pstore /sys/fs/pstore ffff88012aa6f180 ffff88012aa80000 cgroup cgroup /sys/fs/cgroup/blkio ffff88012aa6f340 ffff88012aa80800 cgroup cgroup /sys/fs/cgroup/perf_event ffff88012aa6f500 ffff88012aa81000 cgroup cgroup /sys/fs/cgroup/memory ffff88012aa6f6c0 ffff88012aa81800 cgroup cgroup /sys/fs/cgroup/net_cls,net_prio ffff88012aa6f880 ffff88012aa82000 cgroup cgroup /sys/fs/cgroup/devices ffff88012aa6fa40 ffff88012aa82800 cgroup cgroup /sys/fs/cgroup/pids ffff88012aa6fc00 ffff88012aa83000 cgroup cgroup /sys/fs/cgroup/cpu,cpuacct ffff88012aa6fdc0 ffff88012aa83800 cgroup cgroup /sys/fs/cgroup/freezer ffff88012ab10000 ffff88012aa84000 cgroup cgroup /sys/fs/cgroup/cpuset ffff88012ab101c0 ffff88012aa84800 cgroup cgroup /sys/fs/cgroup/hugetlb ffff880138ccae00 ffff8800b6cc6800 configfs configfs /sys/kernel/config ffff880138ccafc0 ffff8800b6385800 ext4 /dev/nbd0 / ffff88012ab11a40 ffff88012aa85000 rpc_pipefs rpc_pipefs /var/lib/nfs/rpc_pipefs ffff88012b2a8c40 ffff8800b5cb3000 autofs systemd-1 /proc/sys/fs/binfmt_misc ffff880137668540 ffff880139947800 debugfs debugfs /sys/kernel/debug ffff880137668700 ffff88012b2e8000 mqueue mqueue /dev/mqueue ffff88012ab11dc0 ffff8800b637e800 hugetlbfs hugetlbfs /dev/hugepages ffff88012ab11c00 ffff88012a49a000 binfmt_misc binfmt_misc /proc/sys/fs/binfmt_misc/ ffff880138ccb180 ffff8800b637a800 ramfs none /mnt ffff88012b2a8fc0 ffff8800b6fa8000 tmpfs none /var/lib/stateless/writable ffff880138ccb340 ffff8800b637d800 squashfs /dev/vda /home/green/git/lustre-release ffff88012b2a9180 ffff8800b6fa8000 tmpfs none /var/cache/man ffff880138ccb500 ffff8800b6fa8000 tmpfs none /var/log ffff8801376688c0 ffff8800b6fa8000 tmpfs none /var/lib/dbus ffff880137668a80 ffff8800b6fa8000 tmpfs none /tmp ffff880137668c40 ffff8800b6fa8000 tmpfs none /var/lib/dhclient ffff8801368a01c0 ffff8800b6fa8000 tmpfs none /var/tmp ffff880138ccb6c0 ffff8800b6fa8000 tmpfs none /var/lib/NetworkManager ffff880138ccb880 ffff8800b6fa8000 tmpfs none /var/lib/systemd/random-seed ffff880138ccba40 ffff8800b6fa8000 tmpfs none /var/spool ffff880138ccbc00 ffff8800b6fa8000 tmpfs none /var/lib/nfs ffff880137668e00 ffff8800b6fa8000 tmpfs none /var/lib/gssproxy ffff8801368a0380 ffff8800b6fa8000 tmpfs none /var/lib/logrotate ffff880138ccbdc0 ffff8800b6fa8000 tmpfs none /etc ffff8801368a0540 ffff8800b6fa8000 tmpfs none /var/lib/rsyslog ffff880137668fc0 ffff8800b6fa8000 tmpfs none /var/lib/dhclient/var/lib/dhclient ffff880137669180 ffff8800b6fac000 nfs4 192.168.200.253:/exports/state/oleg133-client.virtnet /var/lib/stateless/state ffff8801368a0700 ffff8800b6fac000 nfs4 192.168.200.253:/exports/state/oleg133-client.virtnet /boot ffff880137669340 ffff8800b6fac000 nfs4 192.168.200.253:/exports/state/oleg133-client.virtnet /etc/etc/kdump.conf ffff8801368a08c0 ffff88012aa85000 rpc_pipefs sunrpc /var/lib/nfs/var/lib/nfs/rpc_pipefs ffff8800b3776380 ffff8800ad83f800 nfs4 192.168.200.253://exports/testreports/50430/testresults/racer-ldiskfs-DNE-centos7_x86_64-centos7_x86_64 /tmp/tmp/testlogs ffff8801368a1340 ffff8800b5c90000 tmpfs tmpfs /run/user/0 ffff8800b37768c0 ffff8800b637d800 squashfs /dev/vda /usr/sbin/mount.lustre ffff8800b3564c40 ffff8800ab13a000 lustre 192.168.201.133@tcp:/lustre /mnt/lustre ffff8800b3777180 ffff8800b5d39800 lustre 192.168.201.133@tcp:/lustre /mnt/lustre2 +-------------------------------+ >----------------------| Last 40 lines of dmesg buffer |----------------------< +-------------------------------+ [ 182.891070] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.3-2.fc40 04/01/2014 [ 182.896816] task: ffff88009f453330 ti: ffff88012f570000 task.ti: ffff88012f570000 [ 182.904706] RIP: 0010:[] [] osc_io_submit+0x142/0x720 [osc] [ 182.910571] RSP: 0018:ffff88012f5736c8 EFLAGS: 00010246 [ 182.916430] RAX: 0000000000000000 RBX: 0000000000000081 RCX: ffff8800a1c8b210 [ 182.919938] RDX: 0000000000020081 RSI: ffff8800a0913340 RDI: ffffea000497f240 [ 182.924823] RBP: ffff88012f573768 R08: ffff8800a5b93d38 R09: 0000000000000002 [ 182.930943] R10: 0000000000000000 R11: 0000000000000000 R12: ffff8800a5b93d38 [ 182.936314] R13: ffff8800a01eab60 R14: ffff88012bd1f538 R15: 0000000000000000 [ 182.938395] FS: 00007fd163465740(0000) GS:ffff88013e280000(0000) knlGS:0000000000000000 [ 182.942021] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 182.945654] CR2: 000000000000012e CR3: 000000009bd20000 CR4: 0000000000160fe0 [ 182.955263] Call Trace: [ 182.957506] [] cl_io_submit_rw+0x72/0x190 [obdclass] [ 182.965899] [] lov_io_submit+0x1b4/0x3a0 [lov] [ 182.968438] [] cl_io_submit_rw+0x72/0x190 [obdclass] [ 182.973100] [] ll_direct_IO_impl+0x530/0xef0 [lustre] [ 182.979336] [] ll_direct_IO+0x7c/0xa0 [lustre] [ 182.987116] [] generic_file_aio_read+0x24e/0x290 [ 182.989478] [] ? vvp_prep_size+0x20c/0x2f0 [lustre] [ 182.994812] [] vvp_io_read_start+0x779/0xa60 [lustre] [ 183.000455] [] ? cl_lock_request+0x67/0x210 [obdclass] [ 183.005275] [] cl_io_start+0x6d/0x150 [obdclass] [ 183.012285] [] cl_io_loop+0x9f/0x230 [obdclass] [ 183.017813] [] ll_file_io_generic+0x36b/0x1000 [lustre] [ 183.022872] [] ? do_raw_spin_unlock+0x49/0x90 [ 183.029924] [] do_file_read_iter+0xc46/0x1080 [lustre] [ 183.035680] [] ? do_raw_spin_unlock+0x49/0x90 [ 183.039764] [] ? _raw_spin_unlock+0xe/0x20 [ 183.042105] [] ll_file_read_iter+0x2d/0x40 [lustre] [ 183.051061] [] ll_file_aio_read+0x1b1/0x210 [lustre] [ 183.052614] [] ll_file_read+0x111/0x1e0 [lustre] [ 183.054701] [] vfs_read+0xb9/0x1c0 [ 183.056341] [] SyS_pread64+0x92/0xc0 [ 183.059877] [] ? SyS_lseek+0xa0/0x100 [ 183.061278] [] system_call_fastpath+0x1f/0x24 [ 183.062795] Code: da 80 ca 80 41 0f b6 46 12 49 8b 7e f0 83 e0 c0 3c 80 0f 44 da e8 6f 08 8e ff 89 da 81 ca 00 00 02 00 84 c0 49 8b 46 18 0f 45 da 80 2e 01 00 00 02 0f 85 e1 01 00 00 49 8b 44 24 08 49 8d 4c [ 183.096823] RIP [] osc_io_submit+0x142/0x720 [osc] [ 183.100943] RSP [ 183.102626] CR2: 000000000000012e ****************************************************************************** ************************ A Summary Of Problems Found ************************* ****************************************************************************** -------------------- A list of all +++WARNING+++ messages -------------------- PARTIAL DUMP with size(vmcore) < 25% size(RAM) High Load Averages: 175.95, 43.81, 14.65 There are 3 threads running in their own namespaces Use 'taskinfo --ns' to get more details Panic while we were doing sync on FS ------------------------------------------------------------------------------ ** Execution took 12.53s (real) 7.31s (CPU), Child processes: 5.18s