linux-kernel - [mhiramat:topic/fprobe-on-fgraph] [function_graph] ab712273e5: WARNING:at_kernel/trace/trace.c:#run_tracer

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: <202402292204.c1f77860-oliver.sang@intel.com>
Date: Thu, 29 Feb 2024 22:38:39 +0800
From: kernel test robot <oliver.sang@...el.com>
To: Masami Hiramatsu <mhiramat@...nel.org>
CC: <oe-lkp@...ts.linux.dev>, <lkp@...el.com>, <linux-kernel@...r.kernel.org>,
	<linux-trace-kernel@...r.kernel.org>, <oliver.sang@...el.com>
Subject: [mhiramat:topic/fprobe-on-fgraph] [function_graph] ab712273e5:
 WARNING:at_kernel/trace/trace.c:#run_tracer_selftest



Hello,

kernel test robot noticed "WARNING:at_kernel/trace/trace.c:#run_tracer_selftest" on:

commit: ab712273e5b93b2162bd25823c50afa067c971d7 ("function_graph: Pass ftrace_regs to entryfunc")
https://git.kernel.org/cgit/linux/kernel/git/mhiramat/linux.git topic/fprobe-on-fgraph

in testcase: boot

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

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


+-------------------------------------------------------------+------------+------------+
|                                                             | 18e3163a72 | ab712273e5 |
+-------------------------------------------------------------+------------+------------+
| WARNING:at_kernel/trace/trace.c:#run_tracer_selftest        | 0          | 17         |
| EIP:run_tracer_selftest                                     | 0          | 17         |
+-------------------------------------------------------------+------------+------------+


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/202402292204.c1f77860-oliver.sang@intel.com


[    9.224340][    T1] ------------[ cut here ]------------
[ 9.225209][ T1] WARNING: CPU: 1 PID: 1 at kernel/trace/trace.c:2053 run_tracer_selftest (kernel/trace/trace.c:2053 (discriminator 1)) 
[    9.226920][    T1] Modules linked in:
[    9.227542][    T1] CPU: 1 PID: 1 Comm: swapper/0 Not tainted 6.8.0-rc4-00021-gab712273e5b9 #1 b22c8cda139bb32aef1f09ba4b94f28d718abc25
[    9.229490][    T1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.16.2-debian-1.16.2-1 04/01/2014
[ 9.230911][ T1] EIP: run_tracer_selftest (kernel/trace/trace.c:2053 (discriminator 1)) 
[ 9.231772][ T1] Code: 00 00 00 00 8b 15 5c 14 27 c3 b9 ff ff ff ff a1 a8 14 27 c3 e8 23 60 ff ff e9 8c fe ff ff c7 04 24 c3 18 ca c2 e8 ea 9d f4 ff <0f> 0b be ff ff ff ff e9 60 ff ff ff be f4 ff ff ff e9 56 ff ff ff
All code
========
   0:	00 00                	add    %al,(%rax)
   2:	00 00                	add    %al,(%rax)
   4:	8b 15 5c 14 27 c3    	mov    -0x3cd8eba4(%rip),%edx        # 0xffffffffc3271466
   a:	b9 ff ff ff ff       	mov    $0xffffffff,%ecx
   f:	a1 a8 14 27 c3 e8 23 	movabs 0xff6023e8c32714a8,%eax
  16:	60 ff 
  18:	ff                   	(bad)
  19:	e9 8c fe ff ff       	jmp    0xfffffffffffffeaa
  1e:	c7 04 24 c3 18 ca c2 	movl   $0xc2ca18c3,(%rsp)
  25:	e8 ea 9d f4 ff       	call   0xfffffffffff49e14
  2a:*	0f 0b                	ud2		<-- trapping instruction
  2c:	be ff ff ff ff       	mov    $0xffffffff,%esi
  31:	e9 60 ff ff ff       	jmp    0xffffffffffffff96
  36:	be f4 ff ff ff       	mov    $0xfffffff4,%esi
  3b:	e9 56 ff ff ff       	jmp    0xffffffffffffff96

Code starting with the faulting instruction
===========================================
   0:	0f 0b                	ud2
   2:	be ff ff ff ff       	mov    $0xffffffff,%esi
   7:	e9 60 ff ff ff       	jmp    0xffffffffffffff6c
   c:	be f4 ff ff ff       	mov    $0xfffffff4,%esi
  11:	e9 56 ff ff ff       	jmp    0xffffffffffffff6c
[    9.234972][    T1] EAX: 00000007 EBX: c34453a0 ECX: 00000000 EDX: 00000000
[    9.234972][    T1] ESI: ffffffff EDI: c3479760 EBP: c4c47e84 ESP: c4c47e70
[    9.236035][    T1] DS: 007b ES: 007b FS: 00d8 GS: 0000 SS: 0068 EFLAGS: 00010246
[    9.237240][    T1] CR0: 80050033 CR2: 00000000 CR3: 03739000 CR4: 000406d0
[    9.238361][    T1] Call Trace:
[ 9.238877][ T1] ? show_regs (arch/x86/kernel/dumpstack.c:479) 
[ 9.238912][ T1] ? run_tracer_selftest (kernel/trace/trace.c:2053 (discriminator 1)) 
[ 9.239756][ T1] ? __warn (kernel/panic.c:677) 
[ 9.240397][ T1] ? run_tracer_selftest (kernel/trace/trace.c:2053 (discriminator 1)) 
[ 9.241233][ T1] ? run_tracer_selftest (kernel/trace/trace.c:2053 (discriminator 1)) 
[ 9.242070][ T1] ? report_bug (lib/bug.c:201 lib/bug.c:219) 
[ 9.242782][ T1] ? exc_overflow (arch/x86/kernel/traps.c:251) 
[ 9.242911][ T1] ? handle_bug (arch/x86/kernel/traps.c:238) 
[ 9.243607][ T1] ? exc_invalid_op (arch/x86/kernel/traps.c:259 (discriminator 1)) 
[ 9.244341][ T1] ? __wake_up_klogd+0x49/0x70 
[ 9.245189][ T1] ? preempt_count_sub (kernel/sched/core.c:5881 kernel/sched/core.c:5877 kernel/sched/core.c:5899) 
[ 9.245969][ T1] ? handle_exception (arch/x86/entry/entry_32.S:1056) 
[ 9.246767][ T1] ? exc_overflow (arch/x86/kernel/traps.c:251) 
[ 9.250912][ T1] ? run_tracer_selftest (kernel/trace/trace.c:2053 (discriminator 1)) 
[ 9.251749][ T1] ? exc_overflow (arch/x86/kernel/traps.c:251) 
[ 9.252458][ T1] ? run_tracer_selftest (kernel/trace/trace.c:2053 (discriminator 1)) 
[ 9.253288][ T1] ? graph_depth_read (kernel/trace/trace_functions_graph.c:1349) 
[ 9.254057][ T1] register_tracer (kernel/trace/trace.c:2086 kernel/trace/trace.c:2210) 
[ 9.254800][ T1] ? register_trace_event (kernel/trace/trace_output.c:783) 
[ 9.254910][ T1] ? init_graph_tracefs (kernel/trace/trace_functions_graph.c:1449) 
[ 9.255706][ T1] init_graph_trace (kernel/trace/trace_functions_graph.c:1463) 
[ 9.256448][ T1] do_one_initcall (init/main.c:1236) 
[ 9.257185][ T1] ? parse_args (kernel/params.c:183) 
[ 9.257891][ T1] ? rdinit_setup (init/main.c:1282) 
[ 9.258602][ T1] ? rdinit_setup (init/main.c:1282) 
[ 9.258918][ T1] do_initcalls (init/main.c:1297 init/main.c:1314) 
[ 9.259617][ T1] ? rdinit_setup (init/main.c:1282) 
[ 9.260332][ T1] kernel_init_freeable (init/main.c:1555) 
[ 9.261149][ T1] ? kernel_init (init/main.c:1443) 
[ 9.261870][ T1] ? rest_init (init/main.c:1433) 
[ 9.262567][ T1] kernel_init (init/main.c:1443) 
[ 9.262911][ T1] ? schedule_tail (kernel/sched/core.c:5338) 
[ 9.263644][ T1] ret_from_fork (arch/x86/kernel/process.c:153) 
[ 9.264345][ T1] ? rest_init (init/main.c:1433) 
[ 9.265046][ T1] ret_from_fork_asm (arch/x86/entry/entry_32.S:741) 
[ 9.265798][ T1] entry_INT80_32 (arch/x86/entry/entry_32.S:947) 
[    9.266571][    T1] irq event stamp: 5037117
[ 9.266911][ T1] hardirqs last enabled at (5037127): console_unlock (kernel/printk/printk.c:341 kernel/printk/printk.c:2706 kernel/printk/printk.c:3038) 
[ 9.268327][ T1] hardirqs last disabled at (5037134): console_unlock (kernel/printk/printk.c:339 kernel/printk/printk.c:2706 kernel/printk/printk.c:3038) 
[ 9.269742][ T1] softirqs last enabled at (5036722): __do_softirq (arch/x86/include/asm/preempt.h:26 kernel/softirq.c:400 kernel/softirq.c:582) 
[ 9.270910][ T1] softirqs last disabled at (5036717): do_softirq_own_stack (arch/x86/kernel/irq_32.c:57 arch/x86/kernel/irq_32.c:147) 
[    9.272383][    T1] ---[ end trace 0000000000000000 ]---
[    9.273787][    T1] pinctrl core: initialized pinctrl subsystem
[    9.275831][    T1] workqueue: round-robin CPU selection forced, expect performance impact
[    9.277324][    T1]


The kernel config and materials to reproduce are available at:
https://download.01.org/0day-ci/archive/20240229/202402292204.c1f77860-oliver.sang@intel.com



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