[<prev] [next>] [<thread-prev] [day] [month] [year] [list]
Message-ID: <20210723025719.GA17740@xsang-OptiPlex-9020>
Date: Fri, 23 Jul 2021 10:57:19 +0800
From: kernel test robot <oliver.sang@...el.com>
To: Xiongwei Song <sxwjean@...com>
Cc: 0day robot <lkp@...el.com>, LKML <linux-kernel@...r.kernel.org>,
lkp@...ts.01.org, peterz@...radead.org, mingo@...hat.com,
will@...nel.org, longman@...hat.com, boqun.feng@...il.com,
Xiongwei Song <sxwjean@...il.com>
Subject: [locking/lockdep] e0a77a7a5a: WARNING:bad_unlock_balance_detected
Greeting,
FYI, we noticed the following commit (built with gcc-9):
commit: e0a77a7a5a75e5e5163669d7625c765504cc2f94 ("[RFC PATCH v1 2/3] locking/lockdep: Unify the return values of check_wait_context()")
url: https://github.com/0day-ci/linux/commits/Xiongwei-Song/locking-lockdep-Fix-false-warning-of-check_wait_context/20210711-221747
base: https://git.kernel.org/cgit/linux/kernel/git/tip/tip.git d1bbfd0c7c9f985e57795a7e0cefc209ebf689c0
in testcase: boot
on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G
caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):
+----------------------------------------+------------+------------+
| | 428eeba5e1 | e0a77a7a5a |
+----------------------------------------+------------+------------+
| boot_successes | 26 | 0 |
| boot_failures | 0 | 6 |
| WARNING:bad_unlock_balance_detected | 0 | 6 |
| is_trying_to_release_lock(pool_lock)at | 0 | 6 |
+----------------------------------------+------------+------------+
If you fix the issue, kindly add following tag
Reported-by: kernel test robot <oliver.sang@...el.com>
[ 0.000000][ T0] WARNING: bad unlock balance detected!
[ 0.000000][ T0] 5.13.0-rc1-00135-ge0a77a7a5a75 #1 Not tainted
[ 0.000000][ T0] -------------------------------------
[ 0.000000][ T0] swapper/0 is trying to release lock (pool_lock) at:
[ 0.000000][ T0] __debug_object_init (kbuild/src/consumer/lib/debugobjects.c:273 kbuild/src/consumer/lib/debugobjects.c:568)
[ 0.000000][ T0] but there are no more locks to release!
[ 0.000000][ T0]
[ 0.000000][ T0] other info that might help us debug this:
[ 0.000000][ T0] no locks held by swapper/0.
[ 0.000000][ T0]
[ 0.000000][ T0] stack backtrace:
[ 0.000000][ T0] CPU: 0 PID: 0 Comm: swapper Not tainted 5.13.0-rc1-00135-ge0a77a7a5a75 #1
[ 0.000000][ T0] Call Trace:
[ 0.000000][ T0] ? lock_release (kbuild/src/consumer/kernel/locking/lockdep.c:5303 kbuild/src/consumer/kernel/locking/lockdep.c:5643)
[ 0.000000][ T0] ? _raw_spin_unlock (kbuild/src/consumer/include/linux/spinlock_api_smp.h:151 kbuild/src/consumer/kernel/locking/spinlock.c:183)
[ 0.000000][ T0] ? __debug_object_init (kbuild/src/consumer/lib/debugobjects.c:273 kbuild/src/consumer/lib/debugobjects.c:568)
[ 0.000000][ T0] ? init_cgroup_housekeeping (kbuild/src/consumer/include/linux/lockdep.h:195 kbuild/src/consumer/include/linux/lockdep.h:202 kbuild/src/consumer/include/linux/lockdep.h:208 kbuild/src/consumer/kernel/cgroup/cgroup.c:1909)
[ 0.000000][ T0] ? init_cgroup_root (kbuild/src/consumer/kernel/cgroup/cgroup.c:1922)
[ 0.000000][ T0] ? cgroup_init_early (kbuild/src/consumer/kernel/cgroup/cgroup.c:5614)
[ 0.000000][ T0] ? start_kernel (kbuild/src/consumer/arch/x86/include/asm/irqflags.h:40 kbuild/src/consumer/arch/x86/include/asm/irqflags.h:75 kbuild/src/consumer/init/main.c:886)
[ 0.000000][ T0] ? copy_bootdata (kbuild/src/consumer/arch/x86/kernel/head64.c:433)
[ 0.000000][ T0] ? secondary_startup_64_no_verify (kbuild/src/consumer/arch/x86/kernel/head_64.S:283)
[ 0.000000][ T0] Linux version 5.13.0-rc1-00135-ge0a77a7a5a75 (kbuild@...bfb9d9f4c) (gcc-9 (Debian 9.3.0-22) 9.3.0, GNU ld (GNU Binutils for Debian) 2.35.2) #1 Thu Jul 22 11:35:57 CST 2021
[ 0.000000][ T0] Command line: ip=::::vm-snb-147::dhcp root=/dev/ram0 user=lkp job=/lkp/jobs/scheduled/vm-snb-147/boot-1-yocto-x86_64-minimal-20190520.cgz-e0a77a7a5a75e5e5163669d7625c765504cc2f94-20210723-25037-1fky0q3-4.yaml ARCH=x86_64 kconfig=x86_64-randconfig-r012-20210713 branch=linux-review/Xiongwei-Song/locking-lockdep-Fix-false-warning-of-check_wait_context/20210711-221747 commit=e0a77a7a5a75e5e5163669d7625c765504cc2f94 BOOT_IMAGE=/pkg/linux/x86_64-randconfig-r012-20210713/gcc-9/e0a77a7a5a75e5e5163669d7625c765504cc2f94/vmlinuz-5.13.0-rc1-00135-ge0a77a7a5a75 vmalloc=512M initramfs_async=0 page_owner=on max_uptime=600 RESULT_ROOT=/result/boot/1/vm-snb/yocto-x86_64-minimal-20190520.cgz/x86_64-randconfig-r012-20210713/gcc-9/e0a77a7a5a75e5e5163669d7625c765504cc2f94/3 LKP_SERVER=internal-lkp-server selinux=0 debug apic=debug sysrq_always_enabled rcupdate.rcu_cpu_stall_timeout=100 net.ifnames=0 printk.devkmsg=on panic=-1 softlockup_panic=1 nmi_watchdog=panic oops=panic load_
[ 0.000000][ T0] KERNEL supported cpus:
[ 0.000000][ T0] Intel GenuineIntel
[ 0.000000][ T0] Centaur CentaurHauls
[ 0.000000][ T0] x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers'
[ 0.000000][ T0] x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers'
[ 0.000000][ T0] x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers'
[ 0.000000][ T0] x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256
[ 0.000000][ T0] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
[ 0.000000][ T0] BIOS-provided physical RAM map:
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[ 0.000000][ T0] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdffff] usable
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000bffe0000-0x00000000bfffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
[ 0.000000][ T0] BIOS-e820: [mem 0x0000000100000000-0x000000043fffffff] usable
[ 0.000000][ T0] printk: debug: ignoring loglevel setting.
[ 0.000000][ T0] printk: bootconsole [earlyser0] enabled
[ 0.000000][ T0] NX (Execute Disable) protection: active
[ 0.000000][ T0] SMBIOS 2.8 present.
[ 0.000000][ T0] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.12.0-1 04/01/2014
[ 0.000000][ T0] Hypervisor detected: KVM
[ 0.000000][ T0] kvm-clock: Using msrs 4b564d01 and 4b564d00
[ 0.000000][ T0] kvm-clock: cpu 0, msr 5a477001, primary cpu clock
[ 0.000006][ T0] kvm-clock: using sched offset of 1327495314 cycles
[ 0.001114][ T0] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
[ 0.004079][ T0] tsc: Detected 2493.988 MHz processor
[ 0.006744][ T0] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
[ 0.008135][ T0] e820: remove [mem 0x000a0000-0x000fffff] usable
[ 0.009276][ T0] last_pfn = 0x440000 max_arch_pfn = 0x400000000
[ 0.010470][ T0] x86/PAT: PAT support disabled because CONFIG_X86_PAT is disabled in the kernel.
[ 0.012198][ T0] x86/PAT: Configuration [0-7]: WB WT UC- UC WB WT UC- UC
Memory KASLR using RDTSC...
[ 0.014038][ T0] last_pfn = 0xbffe0 max_arch_pfn = 0x400000000
[ 0.015131][ T0] Scan for SMP in [mem 0x00000000-0x000003ff]
[ 0.016143][ T0] Scan for SMP in [mem 0x0009fc00-0x0009ffff]
[ 0.017017][ T0] Scan for SMP in [mem 0x000f0000-0x000fffff]
[ 0.025962][ T0] found SMP MP-table at [mem 0x000f5a80-0x000f5a8f]
[ 0.027214][ T0] mpc: f5a90-f5b74
[ 0.030043][ T0] RAMDISK: [mem 0x7f797000-0x7fffffff]
[ 0.031073][ T0] ACPI: Early table checksum verification disabled
[ 0.032219][ T0] ACPI: RSDP 0x00000000000F5850 000014 (v00 BOCHS )
[ 0.033450][ T0] ACPI: RSDT 0x00000000BFFE15C9 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001)
[ 0.035153][ T0] ACPI: FACP 0x00000000BFFE149D 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001)
[ 0.036541][ T0] ACPI: DSDT 0x00000000BFFE0040 00145D (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001)
[ 0.037869][ T0] ACPI: FACS 0x00000000BFFE0000 000040
[ 0.038613][ T0] ACPI: APIC 0x00000000BFFE1511 000080 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001)
[ 0.040326][ T0] ACPI: HPET 0x00000000BFFE1591 000038 (v01 BOCHS BXPCHPET 00000001 BXPC 00000001)
[ 0.042095][ T0] ACPI: Reserving FACP table memory at [mem 0xbffe149d-0xbffe1510]
[ 0.043560][ T0] ACPI: Reserving DSDT table memory at [mem 0xbffe0040-0xbffe149c]
[ 0.045025][ T0] ACPI: Reserving FACS table memory at [mem 0xbffe0000-0xbffe003f]
[ 0.046492][ T0] ACPI: Reserving APIC table memory at [mem 0xbffe1511-0xbffe1590]
[ 0.047863][ T0] ACPI: Reserving HPET table memory at [mem 0xbffe1591-0xbffe15c8]
[ 0.049237][ T0] ACPI: Local APIC address 0xfee00000
[ 0.050155][ T0] mapped APIC to ffffffffff5fd000 ( fee00000)
[ 0.051437][ T0] cma: dma_contiguous_reserve(limit 440000000)
[ 0.156468][ T0] Zone ranges:
[ 0.157142][ T0] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.158408][ T0] DMA32 [mem 0x0000000001000000-0x00000000ffffffff]
[ 0.159598][ T0] Normal [mem 0x0000000100000000-0x000000043fffffff]
[ 0.160801][ T0] Movable zone start for each node
[ 0.161703][ T0] Early memory node ranges
[ 0.162412][ T0] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.163664][ T0] node 0: [mem 0x0000000000100000-0x00000000bffdffff]
[ 0.164905][ T0] node 0: [mem 0x0000000100000000-0x000000043fffffff]
[ 0.166193][ T0] Initmem setup node 0 [mem 0x0000000000001000-0x000000043fffffff]
[ 0.167603][ T0] On node 0 totalpages: 4194174
[ 0.168453][ T0] DMA zone: 56 pages used for memmap
[ 0.169328][ T0] DMA zone: 21 pages reserved
[ 0.170204][ T0] DMA zone: 3998 pages, LIFO batch:0
[ 0.171680][ T0] DMA zone: 28770 pages in unavailable ranges
[ 0.172690][ T0] DMA32 zone: 10696 pages used for memmap
[ 0.173664][ T0] DMA32 zone: 782304 pages, LIFO batch:63
[ 0.185335][ T0] DMA32 zone: 32 pages in unavailable ranges
[ 0.186534][ T0] Normal zone: 46592 pages used for memmap
[ 0.187533][ T0] Normal zone: 3407872 pages, LIFO batch:63
To reproduce:
# build kernel
cd linux
cp config-5.13.0-rc1-00135-ge0a77a7a5a75 .config
make HOSTCC=gcc-9 CC=gcc-9 ARCH=x86_64 olddefconfig prepare modules_prepare bzImage
git clone https://github.com/intel/lkp-tests.git
cd lkp-tests
bin/lkp qemu -k <bzImage> job-script # job-script is attached in this email
---
0DAY/LKP+ Test Infrastructure Open Source Technology Center
https://lists.01.org/hyperkitty/list/lkp@lists.01.org Intel Corporation
Thanks,
Oliver Sang
View attachment "config-5.13.0-rc1-00135-ge0a77a7a5a75" of type "text/plain" (135828 bytes)
View attachment "job-script" of type "text/plain" (4693 bytes)
Download attachment "dmesg.xz" of type "application/x-xz" (13892 bytes)
Powered by blists - more mailing lists