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: <202404151046.448e2d6e-lkp@intel.com>
Date: Mon, 15 Apr 2024 10:42:37 +0800
From: kernel test robot <oliver.sang@...el.com>
To: Kairui Song <kasong@...cent.com>
CC: <oe-lkp@...ts.linux.dev>, <lkp@...el.com>, Andrew Morton
	<akpm@...ux-foundation.org>, Matthew Wilcox <willy@...radead.org>,
	<linux-fsdevel@...r.kernel.org>, <linux-kernel@...r.kernel.org>,
	<oliver.sang@...el.com>
Subject: [akpm-mm:mm-unstable] [lib/xarray]  ecc70b3e0b:
 WARNING:suspicious_RCU_usage



Hello,

kernel test robot noticed "WARNING:suspicious_RCU_usage" on:

commit: ecc70b3e0b318995571df44b14e05ff75aed9c71 ("lib/xarray: introduce a new helper xas_get_order")
https://git.kernel.org/cgit/linux/kernel/git/akpm/mm.git mm-unstable

in testcase: boot

compiler: gcc-13
test machine: qemu-system-i386 -enable-kvm -cpu SandyBridge -smp 2 -m 4G

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


+---------------------------------------------------------------------+------------+------------+
|                                                                     | 24b488a793 | ecc70b3e0b |
+---------------------------------------------------------------------+------------+------------+
| WARNING:suspicious_RCU_usage                                        | 0          | 18         |
| include/linux/xarray.h:#suspicious_rcu_dereference_check()usage     | 0          | 18         |
| include/linux/xarray.h:#suspicious_rcu_dereference_protected()usage | 0          | 18         |
+---------------------------------------------------------------------+------------+------------+


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/202404151046.448e2d6e-lkp@intel.com


[    9.238389][    T1] WARNING: suspicious RCU usage
[    9.238967][    T1] 6.9.0-rc2-00175-gecc70b3e0b31 #1 Not tainted
[    9.239710][    T1] -----------------------------
[    9.240287][    T1] include/linux/xarray.h:1200 suspicious rcu_dereference_check() usage!
[    9.241252][    T1]
[    9.241252][    T1] other info that might help us debug this:
[    9.241252][    T1]
[    9.242399][    T1]
[    9.242399][    T1] rcu_scheduler_active = 2, debug_locks = 1
[    9.243291][    T1] no locks held by swapper/1.
[    9.243821][    T1]
[    9.243821][    T1] stack backtrace:
[    9.244507][    T1] CPU: 0 PID: 1 Comm: swapper Not tainted 6.9.0-rc2-00175-gecc70b3e0b31 #1
[    9.245242][    T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[    9.245242][    T1] Call Trace:
[ 9.245242][ T1] dump_stack_lvl (lib/dump_stack.c:117 (discriminator 1) lib/dump_stack.c:97 (discriminator 1)) 
[ 9.245242][ T1] dump_stack (lib/dump_stack.c:124) 
[ 9.245242][ T1] lockdep_rcu_suspicious (include/linux/context_tracking.h:153 kernel/locking/lockdep.c:6713) 
[ 9.245242][ T1] xas_start (include/linux/xarray.h:1200 (discriminator 11) include/linux/xarray.h:1198 (discriminator 11) lib/xarray.c:190 (discriminator 11)) 
[ 9.245242][ T1] xas_load (lib/xarray.c:237) 
[ 9.245242][ T1] xas_store (lib/xarray.c:789) 
[ 9.245242][ T1] ? check_xas_get_order+0xab/0xd8 
[ 9.245242][ T1] ? lock_release (kernel/locking/lockdep.c:467 (discriminator 4) kernel/locking/lockdep.c:5776 (discriminator 4)) 
[ 9.245242][ T1] check_xas_get_order+0xbf/0xd8 
[ 9.245242][ T1] xarray_checks (lib/test_xarray.c:2070) 
[ 9.245242][ T1] do_one_initcall (init/main.c:1238) 
[ 9.245242][ T1] ? parameq (include/linux/fortify-string.h:250 kernel/params.c:99) 
[ 9.245242][ T1] ? check_move+0xbe8/0xbe8 
[ 9.245242][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 9.245242][ T1] ? rest_init (init/main.c:1429) 
[ 9.245242][ T1] kernel_init_freeable (init/main.c:1552) 
[ 9.245242][ T1] kernel_init (init/main.c:1439) 
[ 9.245242][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 9.245242][ T1] ? rest_init (init/main.c:1429) 
[ 9.245242][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 9.245242][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:944) 
[    9.258425][    T1]
[    9.258700][    T1] =============================
[    9.259264][    T1] WARNING: suspicious RCU usage
[    9.259829][    T1] 6.9.0-rc2-00175-gecc70b3e0b31 #1 Not tainted
[    9.260521][    T1] -----------------------------
[    9.261082][    T1] include/linux/xarray.h:1216 suspicious rcu_dereference_check() usage!
[    9.262017][    T1]
[    9.262017][    T1] other info that might help us debug this:
[    9.262017][    T1]
[    9.263197][    T1]
[    9.263197][    T1] rcu_scheduler_active = 2, debug_locks = 1
[    9.264126][    T1] no locks held by swapper/1.
[    9.264678][    T1]
[    9.264678][    T1] stack backtrace:
[    9.265386][    T1] CPU: 0 PID: 1 Comm: swapper Not tainted 6.9.0-rc2-00175-gecc70b3e0b31 #1
[    9.266369][    T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[    9.267564][    T1] Call Trace:
[ 9.267954][ T1] dump_stack_lvl (lib/dump_stack.c:117 (discriminator 1) lib/dump_stack.c:97 (discriminator 1)) 
[ 9.268481][ T1] dump_stack (lib/dump_stack.c:124) 
[ 9.268937][ T1] lockdep_rcu_suspicious (include/linux/context_tracking.h:153 kernel/locking/lockdep.c:6713) 
[ 9.269375][ T1] xas_load (include/linux/xarray.h:1216 (discriminator 11) include/linux/xarray.h:1212 (discriminator 11) lib/xarray.c:206 (discriminator 11) lib/xarray.c:244 (discriminator 11)) 
[ 9.269375][ T1] xas_store (lib/xarray.c:789) 
[ 9.269375][ T1] ? check_xas_get_order+0xab/0xd8 
[ 9.269375][ T1] ? lock_release (kernel/locking/lockdep.c:467 (discriminator 4) kernel/locking/lockdep.c:5776 (discriminator 4)) 
[ 9.269375][ T1] check_xas_get_order+0xbf/0xd8 
[ 9.269375][ T1] xarray_checks (lib/test_xarray.c:2070) 
[ 9.269375][ T1] do_one_initcall (init/main.c:1238) 
[ 9.269375][ T1] ? parameq (include/linux/fortify-string.h:250 kernel/params.c:99) 
[ 9.269375][ T1] ? check_move+0xbe8/0xbe8 
[ 9.269375][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 9.269375][ T1] ? rest_init (init/main.c:1429) 
[ 9.269375][ T1] kernel_init_freeable (init/main.c:1552) 
[ 9.269375][ T1] kernel_init (init/main.c:1439) 
[ 9.269375][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 9.269375][ T1] ? rest_init (init/main.c:1429) 
[ 9.269375][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 9.269375][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:944) 
[    9.278798][    T1]
[    9.279064][    T1] =============================
[    9.279608][    T1] WARNING: suspicious RCU usage
[    9.280153][    T1] 6.9.0-rc2-00175-gecc70b3e0b31 #1 Not tainted
[    9.280831][    T1] -----------------------------
[    9.281417][    T1] include/linux/xarray.h:1225 suspicious rcu_dereference_protected() usage!
[    9.282418][    T1]
[    9.282418][    T1] other info that might help us debug this:
[    9.282418][    T1]
[    9.283603][    T1]
[    9.283603][    T1] rcu_scheduler_active = 2, debug_locks = 1
[    9.284523][    T1] no locks held by swapper/1.
[    9.285076][    T1]
[    9.285076][    T1] stack backtrace:
[    9.285746][    T1] CPU: 0 PID: 1 Comm: swapper Not tainted 6.9.0-rc2-00175-gecc70b3e0b31 #1
[    9.286734][    T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[    9.287903][    T1] Call Trace:
[ 9.288288][ T1] dump_stack_lvl (lib/dump_stack.c:117 (discriminator 1) lib/dump_stack.c:97 (discriminator 1)) 
[ 9.288812][ T1] dump_stack (lib/dump_stack.c:124) 
[ 9.289065][ T1] lockdep_rcu_suspicious (include/linux/context_tracking.h:153 kernel/locking/lockdep.c:6713) 
[ 9.289065][ T1] xas_store (include/linux/xarray.h:1225 (discriminator 7) lib/xarray.c:835 (discriminator 7)) 
[ 9.289065][ T1] check_xas_get_order+0xbf/0xd8 
[ 9.289065][ T1] xarray_checks (lib/test_xarray.c:2070) 
[ 9.289065][ T1] do_one_initcall (init/main.c:1238) 
[ 9.289065][ T1] ? parameq (include/linux/fortify-string.h:250 kernel/params.c:99) 
[ 9.289065][ T1] ? check_move+0xbe8/0xbe8 
[ 9.289065][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 9.289065][ T1] ? rest_init (init/main.c:1429) 
[ 9.289065][ T1] kernel_init_freeable (init/main.c:1552) 
[ 9.289065][ T1] kernel_init (init/main.c:1439) 
[ 9.289065][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 9.289065][ T1] ? rest_init (init/main.c:1429) 
[ 9.289065][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 9.289065][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:944) 
[    9.297406][    T1]
[    9.297671][    T1] =============================
[    9.298216][    T1] WARNING: suspicious RCU usage
[    9.298766][    T1] 6.9.0-rc2-00175-gecc70b3e0b31 #1 Not tainted
[    9.299454][    T1] -----------------------------
[    9.300019][    T1] include/linux/xarray.h:1241 suspicious rcu_dereference_protected() usage!
[    9.301031][    T1]
[    9.301031][    T1] other info that might help us debug this:
[    9.301031][    T1]
[    9.302212][    T1]
[    9.302212][    T1] rcu_scheduler_active = 2, debug_locks = 1
[    9.303143][    T1] no locks held by swapper/1.
[    9.303682][    T1]
[    9.303682][    T1] stack backtrace:
[    9.304357][    T1] CPU: 0 PID: 1 Comm: swapper Not tainted 6.9.0-rc2-00175-gecc70b3e0b31 #1
[    9.305021][    T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[    9.305021][    T1] Call Trace:
[ 9.305021][ T1] dump_stack_lvl (lib/dump_stack.c:117 (discriminator 1) lib/dump_stack.c:97 (discriminator 1)) 
[ 9.305021][ T1] dump_stack (lib/dump_stack.c:124) 
[ 9.305021][ T1] lockdep_rcu_suspicious (include/linux/context_tracking.h:153 kernel/locking/lockdep.c:6713) 
[ 9.305021][ T1] xas_store (include/linux/xarray.h:1241 (discriminator 7) lib/xarray.c:492 (discriminator 7) lib/xarray.c:759 (discriminator 7) lib/xarray.c:844 (discriminator 7)) 
[ 9.305021][ T1] check_xas_get_order+0xbf/0xd8 
[ 9.305021][ T1] xarray_checks (lib/test_xarray.c:2070) 
[ 9.305021][ T1] do_one_initcall (init/main.c:1238) 
[ 9.305021][ T1] ? parameq (include/linux/fortify-string.h:250 kernel/params.c:99) 
[ 9.305021][ T1] ? check_move+0xbe8/0xbe8 
[ 9.305021][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 9.305021][ T1] ? rest_init (init/main.c:1429) 
[ 9.305021][ T1] kernel_init_freeable (init/main.c:1552) 
[ 9.305021][ T1] kernel_init (init/main.c:1439) 
[ 9.305021][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 9.305021][ T1] ? rest_init (init/main.c:1429) 
[ 9.305021][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 9.305021][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:944) 
[   10.414008][    T1] XArray: 6781276 of 6781276 tests passed
[   10.414757][    T1]
[   10.414757][    T1] TEST STARTING
[   10.414757][    T1]
[   94.791459][    T1] maple_tree: 3808238 of 3808238 tests passed
[   94.792303][    T1] test_free_pages: Testing with GFP_KERNEL
[  109.502131][    T1] test_free_pages: Testing with GFP_KERNEL | __GFP_COMP
[  115.289105][    T1] test_free_pages: Test completed
[  115.289894][    T1] ref_tracker: reference already released.
[  115.290608][    T1] ref_tracker: allocated in:
[ 115.291146][ T1] alloctest_ref_tracker_alloc1+0x14/0x18 
[ 115.291955][ T1] test_ref_tracker_init (lib/test_ref_tracker.c:74) 
[ 115.292546][ T1] do_one_initcall (init/main.c:1238) 
[ 115.292922][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 115.292922][ T1] kernel_init_freeable (init/main.c:1552) 
[ 115.292922][ T1] kernel_init (init/main.c:1439) 
[ 115.292922][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 115.292922][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 115.292922][ T1] restore_all_switch_stack (arch/x86/entry/entry_32.S:944) 
[  115.292922][    T1] ref_tracker: freed in:
[ 115.292922][ T1] alloctest_ref_tracker_free+0xf/0x14 
[ 115.292922][ T1] test_ref_tracker_init (lib/test_ref_tracker.c:93 (discriminator 1)) 
[ 115.292922][ T1] do_one_initcall (init/main.c:1238) 
[ 115.292922][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 115.292922][ T1] kernel_init_freeable (init/main.c:1552) 
[ 115.292922][ T1] kernel_init (init/main.c:1439) 
[ 115.292922][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 115.292922][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 115.292922][ T1] restore_all_switch_stack (arch/x86/entry/entry_32.S:944) 
[  115.302044][    T1] ------------[ cut here ]------------
[ 115.302692][ T1] WARNING: CPU: 0 PID: 1 at lib/ref_tracker.c:255 ref_tracker_free (lib/ref_tracker.c:255 (discriminator 1)) 
[  115.303724][    T1] Modules linked in:
[  115.304188][    T1] CPU: 0 PID: 1 Comm: swapper Not tainted 6.9.0-rc2-00175-gecc70b3e0b31 #1
[  115.305200][    T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[ 115.306397][ T1] EIP: ref_tracker_free (lib/ref_tracker.c:255 (discriminator 1)) 
[ 115.307007][ T1] Code: e8 43 54 fc ff eb 96 68 8c dd f0 c1 e8 ef e4 d1 ff 8b 47 0c 5b 85 c0 75 4d 8b 57 10 85 d2 75 31 8b 55 b0 89 f0 e8 4a 9a 4c 00 <0f> 0b b8 ea ff ff ff e9 69 ff ff ff 8d 4e 28 b8 ff ff ff ff 0f c1
All code
========
   0:	e8 43 54 fc ff       	call   0xfffffffffffc5448
   5:	eb 96                	jmp    0xffffffffffffff9d
   7:	68 8c dd f0 c1       	push   $0xffffffffc1f0dd8c
   c:	e8 ef e4 d1 ff       	call   0xffffffffffd1e500
  11:	8b 47 0c             	mov    0xc(%rdi),%eax
  14:	5b                   	pop    %rbx
  15:	85 c0                	test   %eax,%eax
  17:	75 4d                	jne    0x66
  19:	8b 57 10             	mov    0x10(%rdi),%edx
  1c:	85 d2                	test   %edx,%edx
  1e:	75 31                	jne    0x51
  20:	8b 55 b0             	mov    -0x50(%rbp),%edx
  23:	89 f0                	mov    %esi,%eax
  25:	e8 4a 9a 4c 00       	call   0x4c9a74
  2a:*	0f 0b                	ud2		<-- trapping instruction
  2c:	b8 ea ff ff ff       	mov    $0xffffffea,%eax
  31:	e9 69 ff ff ff       	jmp    0xffffffffffffff9f
  36:	8d 4e 28             	lea    0x28(%rsi),%ecx
  39:	b8 ff ff ff ff       	mov    $0xffffffff,%eax
  3e:	0f                   	.byte 0xf
  3f:	c1                   	.byte 0xc1

Code starting with the faulting instruction
===========================================
   0:	0f 0b                	ud2
   2:	b8 ea ff ff ff       	mov    $0xffffffea,%eax
   7:	e9 69 ff ff ff       	jmp    0xffffffffffffff75
   c:	8d 4e 28             	lea    0x28(%rsi),%ecx
   f:	b8 ff ff ff ff       	mov    $0xffffffff,%eax
  14:	0f                   	.byte 0xf
  15:	c1                   	.byte 0xc1
[  115.309186][    T1] EAX: 091e2aa9 EBX: c1f0dd8c ECX: 00000000 EDX: 00000000
[  115.309982][    T1] ESI: c2dc76c0 EDI: c3787200 EBP: c0209edc ESP: c0209e88
[  115.310795][    T1] DS: 007b ES: 007b FS: 0000 GS: 0000 SS: 0068 EFLAGS: 00010246
[  115.311659][    T1] CR0: 80050033 CR2: ffbff000 CR3: 024a0000 CR4: 000406b0
[  115.312468][    T1] DR0: 00000000 DR1: 00000000 DR2: 00000000 DR3: 00000000
[  115.313308][    T1] DR6: fffe0ff0 DR7: 00000400
[  115.313846][    T1] Call Trace:
[ 115.314236][ T1] ? show_regs (arch/x86/kernel/dumpstack.c:479) 
[ 115.314744][ T1] ? ref_tracker_free (lib/ref_tracker.c:255 (discriminator 1)) 
[ 115.315318][ T1] ? __warn (kernel/panic.c:694) 
[ 115.315788][ T1] ? ref_tracker_free (lib/ref_tracker.c:255 (discriminator 1)) 
[ 115.316375][ T1] ? report_bug (lib/bug.c:201 lib/bug.c:219) 
[ 115.316886][ T1] ? exc_overflow (arch/x86/kernel/traps.c:252) 
[ 115.317426][ T1] ? handle_bug (arch/x86/kernel/traps.c:218) 
[ 115.317938][ T1] ? exc_invalid_op (arch/x86/kernel/traps.c:260 (discriminator 1)) 
[ 115.318487][ T1] ? handle_exception (arch/x86/entry/entry_32.S:1047) 
[ 115.319063][ T1] ? tcp_net_metrics_exit_batch (net/ipv4/tcp_metrics.c:1032) 
[ 115.319705][ T1] ? exc_overflow (arch/x86/kernel/traps.c:252) 
[ 115.320206][ T1] ? ref_tracker_free (lib/ref_tracker.c:255 (discriminator 1)) 
[ 115.320784][ T1] ? exc_overflow (arch/x86/kernel/traps.c:252) 
[ 115.321327][ T1] ? ref_tracker_free (lib/ref_tracker.c:255 (discriminator 1)) 
[ 115.321902][ T1] ? alloctest_ref_tracker_free+0xf/0x14 
[ 115.322651][ T1] ? test_ref_tracker_init (arch/x86/include/asm/atomic.h:23 include/linux/atomic/atomic-arch-fallback.h:457 include/linux/atomic/atomic-instrumented.h:33 lib/test_ref_tracker.c:99) 
[ 115.323267][ T1] ? do_one_initcall (init/main.c:1238) 
[ 115.323834][ T1] ? do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 115.324359][ T1] ? kernel_init_freeable (init/main.c:1552) 
[ 115.325001][ T1] ? kernel_init (init/main.c:1439) 
[ 115.325523][ T1] ? ret_from_fork (arch/x86/kernel/process.c:153) 
[ 115.326035][ T1] ? ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 115.326587][ T1] ? entry_INT80_32 (arch/x86/entry/entry_32.S:944) 
[ 115.327143][ T1] alloctest_ref_tracker_free+0xf/0x14 
[ 115.327913][ T1] test_ref_tracker_init (arch/x86/include/asm/atomic.h:23 include/linux/atomic/atomic-arch-fallback.h:457 include/linux/atomic/atomic-instrumented.h:33 lib/test_ref_tracker.c:99) 
[ 115.328534][ T1] do_one_initcall (init/main.c:1238) 
[ 115.329118][ T1] ? parameq (include/linux/fortify-string.h:250 kernel/params.c:99) 
[ 115.329609][ T1] ? maple_tree_seed (lib/test_ref_tracker.c:64) 
[ 115.330189][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 115.330717][ T1] ? rest_init (init/main.c:1429) 
[ 115.331253][ T1] kernel_init_freeable (init/main.c:1552) 
[ 115.331867][ T1] kernel_init (init/main.c:1439) 
[ 115.332370][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 115.332868][ T1] ? rest_init (init/main.c:1429) 
[ 115.333404][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 115.333966][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:944) 
[  115.334513][    T1] irq event stamp: 152972385
[ 115.335040][ T1] hardirqs last enabled at (152972393): console_unlock (arch/x86/include/asm/irqflags.h:42 arch/x86/include/asm/irqflags.h:77 arch/x86/include/asm/irqflags.h:135 kernel/printk/printk.c:341 kernel/printk/printk.c:2731 kernel/printk/printk.c:3050) 
[ 115.336083][ T1] hardirqs last disabled at (152972400): console_unlock (kernel/printk/printk.c:339 (discriminator 3) kernel/printk/printk.c:2731 (discriminator 3) kernel/printk/printk.c:3050 (discriminator 3)) 
[ 115.337125][ T1] softirqs last enabled at (152972420): __do_softirq (kernel/softirq.c:401 (discriminator 2) kernel/softirq.c:583 (discriminator 2)) 
[ 115.338129][ T1] softirqs last disabled at (152972409): do_softirq_own_stack (arch/x86/kernel/irq_32.c:57 arch/x86/kernel/irq_32.c:147) 
[  115.339208][    T1] ---[ end trace 0000000000000000 ]---
[  115.339922][    T1] ref_tracker: selftest@(ptrval) has 1/2 users at
[ 115.339922][ T1] test_ref_tracker_timer_func (lib/test_ref_tracker.c:61) 
[ 115.339922][ T1] call_timer_fn (arch/x86/include/asm/atomic.h:23 include/linux/atomic/atomic-arch-fallback.h:457 include/linux/jump_label.h:260 include/linux/jump_label.h:270 include/trace/events/timer.h:127 kernel/time/timer.c:1794) 
[ 115.339922][ T1] __run_timers (kernel/time/timer.c:1845 kernel/time/timer.c:2418) 
[ 115.339922][ T1] run_timer_softirq (kernel/time/timer.c:2430 kernel/time/timer.c:2438 kernel/time/timer.c:2448) 
[ 115.339922][ T1] __do_softirq (arch/x86/include/asm/atomic.h:23 include/linux/atomic/atomic-arch-fallback.h:457 include/linux/jump_label.h:260 include/linux/jump_label.h:270 include/trace/events/irq.h:142 kernel/softirq.c:555) 
[  115.339922][    T1]
[  115.341107][    T1] ref_tracker: selftest@(ptrval) has 1/2 users at
[ 115.341107][ T1] alloctest_ref_tracker_alloc1+0x14/0x18 
[ 115.341107][ T1] test_ref_tracker_init (lib/test_ref_tracker.c:73) 
[ 115.341107][ T1] do_one_initcall (init/main.c:1238) 
[ 115.341107][ T1] do_initcalls (init/main.c:1299 (discriminator 1) init/main.c:1316 (discriminator 1)) 
[ 115.341107][ T1] kernel_init_freeable (init/main.c:1552) 
[ 115.341107][ T1] kernel_init (init/main.c:1439) 
[ 115.341107][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 115.341107][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:737) 
[ 115.341107][ T1] restore_all_switch_stack (arch/x86/entry/entry_32.S:944) 
[  115.341107][    T1]


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



-- 
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