syzbot
INFO: task hung in trace_set_clr_event
Status:
upstream: reported on 2026/09/09 11:05
Reported-by: syzbot+f23e5fb3e1734d860759@syzkaller.appspotmail.com
First crash: 11d, last: 11d
Sample crash report:
INFO: task syz.3.2022:10943 blocked for more than 143 seconds.
Not tainted syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.3.2022 state:D stack:24192 pid:10943 ppid: 4187 flags:0x00004004
Call Trace:
<TASK>
context_switch kernel/sched/core.c:5049 [inline]
__schedule+0x11c3/0x4350 kernel/sched/core.c:6395
schedule+0x11b/0x1e0 kernel/sched/core.c:6478
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6537
__mutex_lock_common+0xdf5/0x2400 kernel/locking/mutex.c:669
__mutex_lock kernel/locking/mutex.c:729 [inline]
mutex_lock_nested+0x17/0x20 kernel/locking/mutex.c:743
__ftrace_set_clr_event kernel/trace/trace_events.c:1195 [inline]
trace_set_clr_event+0xbe/0x130 kernel/trace/trace_events.c:1261
bpf_get_trace_printk_proto+0x1e/0x80 kernel/trace/bpf_trace.c:408
check_helper_call+0x1df/0x5750 kernel/bpf/verifier.c:6554
do_check+0x62de/0xf150 kernel/bpf/verifier.c:11454
do_check_common+0xe7f/0x16e0 kernel/bpf/verifier.c:13533
do_check_main kernel/bpf/verifier.c:13596 [inline]
bpf_check+0x88c1/0xf6b0 kernel/bpf/verifier.c:14167
bpf_prog_load+0xfdf/0x14e0 kernel/bpf/syscall.c:2354
__sys_bpf+0x532/0x6f0 kernel/bpf/syscall.c:4657
__do_sys_bpf kernel/bpf/syscall.c:4761 [inline]
__se_sys_bpf kernel/bpf/syscall.c:4759 [inline]
__x64_sys_bpf+0x78/0x90 kernel/bpf/syscall.c:4759
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x4c/0xa0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x66/0xd0
RIP: 0033:0x7ff897b28159
RSP: 002b:00007ff895d80028 EFLAGS: 00000246 ORIG_RAX: 0000000000000141
RAX: ffffffffffffffda RBX: 00007ff897daffa0 RCX: 00007ff897b28159
RDX: 0000000000000094 RSI: 0000200000000140 RDI: 0000000000000005
RBP: 00007ff897bbf03b R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ff897db0038 R14: 00007ff897daffa0 R15: 00007ffc61988838
</TASK>
Showing all locks held in the system:
1 lock held by khungtaskd/27:
#0: ffffffff8c31ef60 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
3 locks held by kworker/u4:2/154:
1 lock held by udevd/3557:
#0: ffff8880b913a358 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0x25/0x130 kernel/sched/core.c:475
2 locks held by getty/3944:
#0: ffff88814cb72098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:252
#1: ffffc90002d032e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x594/0x1a50 drivers/tty/n_tty.c:2158
3 locks held by kworker/0:3/4228:
#0: ffff888016c70938 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x75c/0xff0 kernel/workqueue.c:-1
#1: ffffc90002f5fd00 ((work_completion)(&pwq->unbound_release_work)){+.+.}-{0:0}, at: process_one_work+0x79e/0xff0 kernel/workqueue.c:2285
#2: ffffffff8c3239e8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:290 [inline]
#2: ffffffff8c3239e8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x2d1/0x750 kernel/rcu/tree_exp.h:845
2 locks held by kworker/0:7/4265:
#0: ffff888016c72138 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x75c/0xff0 kernel/workqueue.c:-1
#1: ffffc90002dffd00 ((work_completion)(&rew.rew_work)){+.+.}-{0:0}, at: process_one_work+0x79e/0xff0 kernel/workqueue.c:2285
4 locks held by kworker/u4:12/4502:
6 locks held by syz.1.2018/10930:
1 lock held by syz.3.2022/10943:
#0: ffffffff8c36c788 (event_mutex){+.+.}-{3:3}, at: __ftrace_set_clr_event kernel/trace/trace_events.c:1195 [inline]
#0: ffffffff8c36c788 (event_mutex){+.+.}-{3:3}, at: trace_set_clr_event+0xbe/0x130 kernel/trace/trace_events.c:1261
3 locks held by kworker/u4:4/11652:
#0: ffff888016dcd938 ((wq_completion)netns){+.+.}-{0:0}, at: process_one_work+0x75c/0xff0 kernel/workqueue.c:-1
#1: ffffc9000339fd00 (net_cleanup_work){+.+.}-{0:0}, at: process_one_work+0x79e/0xff0 kernel/workqueue.c:2285
#2: ffffffff8c3238f0 (rcu_state.barrier_mutex){+.+.}-{3:3}, at: rcu_barrier+0xa1/0x4c0 kernel/rcu/tree.c:4043
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 27 Comm: khungtaskd Not tainted syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/24/2026
Call Trace:
<TASK>
dump_stack_lvl+0x188/0x250 lib/dump_stack.c:106
nmi_cpu_backtrace+0x3a2/0x3d0 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x163/0x280 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:148 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:212 [inline]
watchdog+0xe1b/0xe60 kernel/hung_task.c:369
kthread+0x42e/0x520 kernel/kthread.c:334
ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:287
</TASK>
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 10930 Comm: syz.1.2018 Not tainted syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/24/2026
RIP: 0010:check_preemption_disabled+0x13/0x110 lib/smp_processor_id.c:13
Code: 42 76 5b c3 00 00 cc 48 c7 c7 e0 44 7a 8a 48 c7 c6 20 45 7a 8a eb 00 55 41 57 41 56 53 48 83 ec 10 65 48 8b 04 25 28 00 00 00 <48> 89 44 24 08 65 8b 05 f9 90 41 76 65 8b 0d 62 eb 41 76 f7 c1 ff
RSP: 0018:ffffc90000dd0a28 EFLAGS: 00000086
RAX: 4232443a19858100 RBX: ffff88802a440000 RCX: 4232443a19858100
RDX: 0000000000000000 RSI: ffffffff8a2b39e0 RDI: ffffffff8a7a4540
RBP: 00000000ffffffff R08: ffffffff8d8b122f R09: 1ffffffff1b16245
R10: dffffc0000000000 R11: fffffbfff1b16246 R12: ffff88802a440000
R13: 0000000000000046 R14: ffff8880b913a358 R15: 00000000ffffffff
FS: 00007f591462d6c0(0000) GS:ffff8880b9100000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f7acfb3b158 CR3: 000000002ab84000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
<IRQ>
lockdep_recursion_inc kernel/locking/lockdep.c:431 [inline]
lock_is_held_type+0x75/0x190 kernel/locking/lockdep.c:5665
lock_is_held include/linux/lockdep.h:287 [inline]
lockdep_assert_rq_held kernel/sched/sched.h:1317 [inline]
cpuacct_charge+0xe0/0x310 kernel/sched/cpuacct.c:334
cgroup_account_cputime include/linux/cgroup.h:794 [inline]
update_curr+0x38e/0x8d0 kernel/sched/fair.c:858
entity_tick kernel/sched/fair.c:4785 [inline]
task_tick_fair+0xd6/0xfd0 kernel/sched/fair.c:11475
scheduler_tick+0x1e2/0x4f0 kernel/sched/core.c:5320
update_process_times+0x1c7/0x200 kernel/time/timer.c:2026
tick_sched_handle kernel/time/tick-sched.c:254 [inline]
tick_sched_timer+0x37d/0x560 kernel/time/tick-sched.c:1473
__run_hrtimer kernel/time/hrtimer.c:1685 [inline]
__hrtimer_run_queues+0x4b0/0xb60 kernel/time/hrtimer.c:1749
hrtimer_interrupt+0x397/0x8b0 kernel/time/hrtimer.c:1811
local_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1097 [inline]
__sysvec_apic_timer_interrupt+0x137/0x4a0 arch/x86/kernel/apic/apic.c:1114
instr_sysvec_apic_timer_interrupt arch/x86/kernel/apic/apic.c:1108 [inline]
sysvec_apic_timer_interrupt+0x9b/0xc0 arch/x86/kernel/apic/apic.c:1108
</IRQ>
<TASK>
asm_sysvec_apic_timer_interrupt+0x16/0x20 arch/x86/include/asm/idtentry.h:676
RIP: 0010:console_trylock_spinning+0x301/0x370 kernel/printk/printk.c:1909
Code: 85 db 74 89 e8 f0 ee 18 00 fb 31 c0 eb 48 e8 e6 ee 18 00 e8 71 53 60 08 48 85 db 74 d1 e8 d7 ee 18 00 fb 48 c7 c7 a0 3a 31 8c <31> f6 ba 01 00 00 00 31 c9 41 b8 01 00 00 00 45 31 c9 68 ca 20 60
RSP: 0018:ffffc900031cf9e0 EFLAGS: 00000246
RAX: ffffffff816020c9 RBX: 0000000000000200 RCX: 0000000000080000
RDX: ffffc90003d43000 RSI: 000000000007ffff RDI: ffffffff8c313aa0
RBP: ffffc900031cfab0 R08: ffffffff901ef0c7 R09: 1ffffffff203de18
R10: dffffc0000000000 R11: fffffbfff203de19 R12: dffffc0000000000
R13: 0000000000000000 R14: 0000000000000000 R15: 1ffff92000639f3c
vprintk_emit+0xa7/0x150 kernel/printk/printk.c:2273
_printk+0xda/0x130 kernel/printk/printk.c:2299
event_subsystem_dir kernel/trace/trace_events.c:2462 [inline]
event_create_dir+0xc34/0xe80 kernel/trace/trace_events.c:2553
__trace_add_new_event kernel/trace/trace_events.c:2957 [inline]
__trace_add_event_dirs kernel/trace/trace_events.c:3169 [inline]
event_trace_add_tracer+0x1a3/0x390 kernel/trace/trace_events.c:3780
trace_array_create_dir+0x77/0x120 kernel/trace/trace.c:9380
trace_array_create+0x6fa/0xc00 kernel/trace/trace.c:9438
instance_mkdir+0xc8/0x120 kernel/trace/trace.c:9473
tracefs_syscall_mkdir+0xb7/0x110 fs/tracefs/inode.c:87
vfs_mkdir+0x386/0x570 fs/namei.c:4116
do_mkdirat+0x1dd/0x5c0 fs/namei.c:4141
__do_sys_mkdirat fs/namei.c:4156 [inline]
__se_sys_mkdirat fs/namei.c:4154 [inline]
__x64_sys_mkdirat+0x85/0x90 fs/namei.c:4154
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x4c/0xa0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x66/0xd0
RIP: 0033:0x7f59163d5159
Code: ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 e8 ff ff ff f7 d8 64 89 01 48
RSP: 002b:00007f591462d028 EFLAGS: 00000246 ORIG_RAX: 0000000000000102
RAX: ffffffffffffffda RBX: 00007f591665cfa0 RCX: 00007f59163d5159
RDX: 00000000000001ff RSI: 0000200000000100 RDI: ffffffffffffff9c
RBP: 00007f591646c03b R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007f591665d038 R14: 00007f591665cfa0 R15: 00007ffd94ed0008
</TASK>
* Struck through repros no longer work on HEAD.