linux-kernel - [sched] ae79270232: WARNING:at_kernel/sched/core.c:#balance

lists.openwall.net		lists / announce owl-users owl-dev john-users john-dev passwdqc-users yescrypt popa3d-users / oss-security kernel-hardening musl sabotage tlsify passwords / crypt-dev xvendor / Bugtraq Full-Disclosure linux-kernel linux-netdev linux-ext4 linux-hardening linux-cve-announce PHC
Open Source and information security mailing list archives

Hash Suite: Windows password security audit tool. GUI, reports in PDF.

[<prev] [next>] [day] [month] [year] [list]

Message-ID: <20210107051851.GA22733@xsang-OptiPlex-9020>
Date:   Thu, 7 Jan 2021 13:18:51 +0800
From:   kernel test robot <oliver.sang@...el.com>
To:     Peter Zijlstra <peterz@...radead.org>
Cc:     kernel test robot <oliver.sang@...el.com>,
        LKML <linux-kernel@...r.kernel.org>, lkp@...ts.01.org,
        lkp@...el.com, aubrey.li@...ux.intel.com, yu.c.chen@...el.com
Subject: [sched]  ae79270232: WARNING:at_kernel/sched/core.c:#balance_push


Greeting,

FYI, we noticed the following commit (built with gcc-9):

commit: ae7927023243dcc7389b2d59b16c09cbbeaecc36 ("sched: Optimize finish_lock_switch()")
https://git.kernel.org/cgit/linux/kernel/git/torvalds/linux.git master


in testcase: rcutorture
version: 
with following parameters:

	runtime: 300s
	test: cpuhotplug
	torture_type: srcu

test-description: rcutorture is rcutorture kernel module load/unload test.
test-url: https://www.kernel.org/doc/Documentation/RCU/torture.txt


on test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 8G

caused below changes (please refer to attached dmesg/kmsg for entire log/backtrace):


+-------------------------------------------------------------------------------------+------------+------------+
|                                                                                     | 5b78f2dc31 | ae79270232 |
+-------------------------------------------------------------------------------------+------------+------------+
| boot_successes                                                                      | 10         | 0          |
| WARNING:at_kernel/sched/core.c:#balance_push                                        | 0          | 10         |
| EIP:balance_push                                                                    | 0          | 10         |
+-------------------------------------------------------------------------------------+------------+------------+


If you fix the issue, kindly add following tag
Reported-by: kernel test robot <oliver.sang@...el.com>


[  249.206338] ------------[ cut here ]------------
[  249.207346] rq->cpu != smp_processor_id()
[  249.207361] WARNING: CPU: 0 PID: 13 at kernel/sched/core.c:7244 balance_push+0x12e/0x180
[  249.209018] Modules linked in: rcutorture torture input_leds led_class rtc_cmos qemu_fw_cfg evdev
[  249.210255] CPU: 0 PID: 13 Comm: rcub/0 Not tainted 5.10.0-rc5-00090-gae7927023243 #1
[  249.211316] EIP: balance_push+0x12e/0x180
[  249.211904] Code: ff 0f 0b e9 0e ff ff ff 8d 74 26 00 80 3d d7 9e e3 4a 00 0f 85 0f ff ff ff c6 05 d7 9e e3 4a 01 68 43 74 82 4a e8 e3 6c ce 00 <0f> 0b 58 e9 f6 fe ff ff 8d b4 26 00 00 00 00 8d 76 00 ba 01 00 00
[  249.214413] EAX: 0000001d EBX: dabf8240 ECX: 00000027 EDX: daa8ff40
[  249.215260] ESI: 410dc000 EDI: be830000 EBP: 410cfe4c ESP: 410cfe40
[  249.216363] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010012
[  249.217653] CR0: 80050033 CR2: 3f9d70ec CR3: 7edae220 CR4: 000406b0
[  249.218872] Call Trace:
[  249.219379]  ? do_balance_callbacks+0x31/0x60
[  249.220063]  ? rt_mutex_setprio+0x180/0x8c0
[  249.220645]  ? find_held_lock+0x29/0x80
[  249.221172]  ? rt_mutex_adjust_prio+0x29/0x60
[  249.221777]  ? task_blocks_on_rt_mutex+0x1a5/0x2a0
[  249.222438]  ? rt_mutex_slowlock+0x86/0x1c0
[  249.223156]  ? rcu_boost_kthread+0x120/0x560
[  249.223789]  ? rcu_boost_kthread+0x7c/0x560
[  249.224364]  ? rt_mutex_lock_nested+0x3e/0x60
[  249.224964]  ? rcu_boost_kthread+0x120/0x560
[  249.225548]  ? rcu_boost_kthread+0x120/0x560
[  249.226137]  ? kthread+0xf0/0x140
[  249.226598]  ? rcu_boost_kthread_setaffinity+0xe0/0xe0
[  249.227297]  ? kthread_delayed_work_timer_fn+0xc0/0xc0
[  249.228029]  ? ret_from_fork+0x19/0x30
[  249.228552] irq event stamp: 202
[  249.229002] hardirqs last  enabled at (201): [<4a3f0055>] _raw_spin_unlock_irqrestore+0x35/0x60
[  249.230174] hardirqs last disabled at (202): [<4a3efd85>] _raw_spin_lock_irqsave+0x65/0xa0
[  249.231289] softirqs last  enabled at (182): [<4a3f1bc1>] __do_softirq+0x301/0x47b
[  249.232332] softirqs last disabled at (175): [<4960d1dd>] do_softirq_own_stack+0x1d/0x40
[  249.233419] ---[ end trace e8113877dca43521 ]---



To reproduce:

        # build kernel
	cd linux
	cp config-5.10.0-rc5-00090-gae7927023243 .config
	make HOSTCC=gcc-9 CC=gcc-9 ARCH=i386 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



Thanks,
Oliver Sang


View attachment "config-5.10.0-rc5-00090-gae7927023243" of type "text/plain" (166212 bytes)

View attachment "job-script" of type "text/plain" (4473 bytes)

Download attachment "dmesg.xz" of type "application/x-xz" (94216 bytes)

View attachment "rcutorture" of type "text/plain" (7194 bytes)