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>] [thread-next>] [day] [month] [year] [list]
Message-ID: <202410151544.7d2292c6-lkp@intel.com>
Date: Tue, 15 Oct 2024 15:47:20 +0800
From: kernel test robot <oliver.sang@...el.com>
To: Peter Zijlstra <peterz@...radead.org>
CC: <oe-lkp@...ts.linux.dev>, <lkp@...el.com>, Sebastian Andrzej Siewior
	<bigeasy@...utronix.de>, <linux-kernel@...r.kernel.org>,
	<oliver.sang@...el.com>
Subject: [peterz-queue:sched/lazy] [sched, x86]  74d850cd4c:
 WARNING:at_kernel/rcu/rcutorture.c:#rcu_torture_stats_print[rcutorture]



Hello,


with this commit, we saw below config diff between this commit and its parent.

--- /pkg/linux/x86_64-randconfig-014-20241011/clang-18/693ed5cdf46ac062aa7713700c77019c60f0ae41/.config 2024-10-13 05:54:47.077017686 +0800
+++ /pkg/linux/x86_64-randconfig-014-20241011/clang-18/74d850cd4c5bc26ce83511b4247ea786eb73217c/.config 2024-10-13 05:42:38.439123587 +0800
@@ -120,9 +120,11 @@ CONFIG_BPF_PRELOAD=y
 # end of BPF subsystem

 CONFIG_PREEMPT_BUILD=y
-CONFIG_PREEMPT_NONE=y
+CONFIG_ARCH_HAS_PREEMPT_LAZY=y
+# CONFIG_PREEMPT_NONE is not set
 # CONFIG_PREEMPT_VOLUNTARY is not set
 # CONFIG_PREEMPT is not set
+CONFIG_PREEMPT_LAZY=y
 # CONFIG_PREEMPT_RT is not set
 CONFIG_PREEMPT_COUNT=y
 CONFIG_PREEMPTION=y


and below reported new issue is not observed on parent.

693ed5cdf46ac062 74d850cd4c5bc26ce83511b4247
---------------- ---------------------------
       fail:runs  %reproduction    fail:runs
           |             |             |
           :6          100%           6:6     dmesg.RIP:rcu_torture_stats_print[rcutorture]
           :6          100%           6:6     dmesg.WARNING:at_kernel/rcu/rcutorture.c:#rcu_torture_stats_print[rcutorture]


kernel test robot noticed "WARNING:at_kernel/rcu/rcutorture.c:#rcu_torture_stats_print[rcutorture]" on:

commit: 74d850cd4c5bc26ce83511b4247ea786eb73217c ("sched, x86: Enable Lazy preemption")
https://git.kernel.org/cgit/linux/kernel/git/peterz/queue.git sched/lazy

in testcase: rcutorture
version: 
with following parameters:

	runtime: 300s
	test: cpuhotplug
	torture_type: busted



config: x86_64-randconfig-014-20241011
compiler: clang-18
test machine: qemu-system-x86_64 -enable-kvm -cpu SandyBridge -smp 2 -m 16G

(please refer to attached dmesg/kmsg for entire log/backtrace)


If you fix the issue in a separate patch/commit (i.e. not just a new version of
the same patch/commit), kindly add following tags
| Reported-by: kernel test robot <oliver.sang@...el.com>
| Closes: https://lore.kernel.org/oe-lkp/202410151544.7d2292c6-lkp@intel.com


The kernel config and materials to reproduce are available at:
https://download.01.org/0day-ci/archive/20241015/202410151544.7d2292c6-lkp@intel.com



[   98.006999][  T543] busted-torture: rtc: 00000000639e821e ver: 6796 tfle: 0 rta: 6796 rtaf: 0 rtf: 6787 rtmbe: 1 rtmbkf: 0/0 rtbe: 0 rtbke: 0 rtbf: 0 rtb: 0 nt: 89 barrier: 0/0:0 read-exits: 64 nocb-toggles: 0:0
[   98.017386][  T543] busted-torture: !!! 
[   98.017662][  T543] ------------[ cut here ]------------
[   98.019330][  T543] WARNING: CPU: 0 PID: 543 at kernel/rcu/rcutorture.c:2258 rcu_torture_stats_print+0x24c/0x610 [rcutorture]
[   98.021831][  T543] Modules linked in: rcutorture torture
[   98.022825][  T543] CPU: 0 UID: 0 PID: 543 Comm: rcu_torture_sta Not tainted 6.12.0-rc1-00037-g74d850cd4c5b #1
[   98.024497][  T543] RIP: 0010:rcu_torture_stats_print+0x24c/0x610 [rcutorture]
[   98.025764][  T543] Code: 9e 00 00 31 db 48 c7 c7 a0 ab 01 a0 44 8b 35 e7 9d 00 00 45 85 f6 0f 95 c3 31 d2 31 c9 89 de e8 9a 60 22 e1 45 85 f6 74 04 90 <0f> 0b 90 48 c7 c7 d0 ab 01 a0 89 de 31 d2 31 c9 e8 7f 60 22 e1 44
[   98.029027][  T543] RSP: 0018:ffffc90000e0fdd0 EFLAGS: 00010202
[   98.030159][  T543] RAX: 17b05ce78fe5d400 RBX: 0000000000000001 RCX: 0000000000000000
[   98.031464][  T543] RDX: 0000000000000000 RSI: 0000000000000001 RDI: ffffffffa001abc0
[   98.032751][  T543] RBP: ffffc90000e0fed0 R08: 0000000000000000 R09: ffffc90000e0fb98
[   98.034230][  T543] R10: ffffc90000e0fb90 R11: ffffffff83caa080 R12: ffff8881423b6100
[   98.035585][  T543] R13: 0000000080000000 R14: 0000000000000001 R15: 000000000000000a
[   98.036942][  T543] FS:  0000000000000000(0000) GS:ffffffff83c8c000(0000) knlGS:0000000000000000
[   98.038435][  T543] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   98.039527][  T543] CR2: 0000000000403034 CR3: 000000013e05e000 CR4: 00000000000406b0
[   98.040903][  T543] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   98.042278][  T543] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[   98.043632][  T543] Call Trace:
[   98.044195][  T543]  <TASK>
[   98.044690][  T543]  ? show_regs+0x5d/0x70
[   98.045452][  T543]  ? __warn+0xa6/0x270
[   98.046168][  T543]  ? rcu_torture_stats_print+0x24c/0x610 [rcutorture]
[   98.047349][  T543]  ? report_bug+0xba/0x160
[   98.048112][  T543]  ? handle_bug+0x55/0x80
[   98.048860][  T543]  ? exc_invalid_op+0x1b/0x50
[   98.049716][  T543]  ? asm_exc_invalid_op+0x1b/0x20
[   98.050675][  T543]  ? rcu_torture_stats_print+0x24c/0x610 [rcutorture]
[   98.051846][  T543]  rcu_torture_stats+0x29/0x70 [rcutorture]
[   98.052839][  T543]  kthread+0x18f/0x1a0
[   98.053600][  T543]  ? rcu_nocb_toggle+0x1b0/0x1b0 [rcutorture]
[   98.054607][  T543]  ? kthread_unuse_mm+0x150/0x150
[   98.055432][  T543]  ret_from_fork+0x46/0x60
[   98.056167][  T543]  ? kthread_unuse_mm+0x150/0x150
[   98.057066][  T543]  ret_from_fork_asm+0x11/0x20
[   98.057974][  T543]  </TASK>
[   98.058501][  T543] irq event stamp: 421
[   98.059184][  T543] hardirqs last  enabled at (429): [<ffffffff811670db>] __console_unlock+0x7b/0xd0
[   98.060748][  T543] hardirqs last disabled at (438): [<ffffffff811670c0>] __console_unlock+0x60/0xd0
[   98.062437][  T543] softirqs last  enabled at (0): [<ffffffff810eb6c6>] copy_process+0x626/0x13e0
[   98.063962][  T543] softirqs last disabled at (0): [<0000000000000000>] 0x0
[   98.065130][  T543] ---[ end trace 0000000000000000 ]---
[   98.237025][  T543] ------------[ cut here ]------------
[   98.238052][  T543] WARNING: CPU: 0 PID: 543 at kernel/rcu/rcutorture.c:2263 rcu_torture_stats_print+0x373/0x610 [rcutorture]
[   98.240000][  T543] Modules linked in: rcutorture torture
[   98.241012][  T543] CPU: 0 UID: 0 PID: 543 Comm: rcu_torture_sta Tainted: G        W          6.12.0-rc1-00037-g74d850cd4c5b #1
[   98.243089][  T543] Tainted: [W]=WARN
[   98.243770][  T543] RIP: 0010:rcu_torture_stats_print+0x373/0x610 [rcutorture]
[   98.244991][  T543] Code: d2 31 c9 e8 8f 5f 22 e1 31 db 41 83 ff 02 48 c7 c7 80 ad 01 a0 0f 9d c3 31 d2 31 c9 89 de e8 74 5f 22 e1 41 83 ff 02 7c 04 90 <0f> 0b 90 48 c7 c7 b0 ad 01 a0 89 de 31 d2 31 c9 e8 58 5f 22 e1 48
[   98.248211][  T543] RSP: 0018:ffffc90000e0fdd0 EFLAGS: 00010202
[   98.249268][  T543] RAX: 17b05ce78fe5d400 RBX: 0000000000000001 RCX: 0000000000000000
[   98.250758][  T543] RDX: 0000000000000000 RSI: 0000000000000001 RDI: ffffffffa001ada0
[   98.252089][  T543] RBP: ffffc90000e0fed0 R08: 0000000000000000 R09: ffffc90000e0fb98
[   98.253480][  T543] R10: ffffc90000e0fb90 R11: ffffffff83caa080 R12: ffff8881423b6100
[   98.254886][  T543] R13: 0000000080000000 R14: 0000000000000000 R15: 000000000000000a
[   98.256171][  T543] FS:  0000000000000000(0000) GS:ffffffff83c8c000(0000) knlGS:0000000000000000
[   98.257778][  T543] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[   98.258942][  T543] CR2: 00007fdbb4f90000 CR3: 0000000140b89000 CR4: 00000000000406b0
[   98.260150][  T543] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[   98.261503][  T543] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
[   98.262832][  T543] Call Trace:
[   98.263391][  T543]  <TASK>
[   98.263916][  T543]  ? show_regs+0x5d/0x70
[   98.264654][  T543]  ? __warn+0xa6/0x270
[   98.265377][  T543]  ? rcu_torture_stats_print+0x373/0x610 [rcutorture]
[   98.266551][  T543]  ? report_bug+0xba/0x160
[   98.267331][  T543]  ? handle_bug+0x55/0x80
[   98.268055][  T543]  ? exc_invalid_op+0x1b/0x50
[   98.268841][  T543]  ? asm_exc_invalid_op+0x1b/0x20
[   98.269772][  T543]  ? rcu_torture_stats_print+0x373/0x610 [rcutorture]
[   98.271002][  T543]  rcu_torture_stats+0x29/0x70 [rcutorture]
[   98.271983][  T543]  kthread+0x18f/0x1a0
[   98.272660][  T543]  ? rcu_nocb_toggle+0x1b0/0x1b0 [rcutorture]
[   98.273784][  T543]  ? kthread_unuse_mm+0x150/0x150
[   98.274621][  T543]  ret_from_fork+0x46/0x60
[   98.275361][  T543]  ? kthread_unuse_mm+0x150/0x150
[   98.276189][  T543]  ret_from_fork_asm+0x11/0x20
[   98.277038][  T543]  </TASK>
[   98.277611][  T543] irq event stamp: 811
[   98.278304][  T543] hardirqs last  enabled at (819): [<ffffffff811670db>] __console_unlock+0x7b/0xd0
[   98.279844][  T543] hardirqs last disabled at (826): [<ffffffff811670c0>] __console_unlock+0x60/0xd0
[   98.281441][  T543] softirqs last  enabled at (0): [<ffffffff810eb6c6>] copy_process+0x626/0x13e0
[   98.282929][  T543] softirqs last disabled at (0): [<0000000000000000>] 0x0
[   98.284155][  T543] ---[ end trace 0000000000000000 ]---
[   98.466994][  T543] Reader Pipe:  49418 0 1 0 1 2 0 1 0 0 47
[   98.468093][  T543] busted-torture: Reader Batch:  49470 0 0 0 0 0 0 0 0 0 0
[   98.469346][  T543] busted-torture: Free-Block Circulation:  6795 6795 6794 6793 6792 6791 6790 6789 6788 6787 0

-- 
0-DAY CI Kernel Test Service
https://github.com/intel/lkp-tests/wiki


Powered by blists - more mailing lists

Powered by Openwall GNU/*/Linux Powered by OpenVZ