INFO: task syz.2.2727:17779 blocked for more than 143 seconds.
Not tainted 6.14.0-rc7-syzkaller-00205-g586de92313fc #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz.2.2727 state:D stack:28528 pid:17779 tgid:17774 ppid:13154 task_flags:0x400140 flags:0x20000004
Call Trace:
context_switch kernel/sched/core.c:5378 [inline]
__schedule+0x190e/0x4c90 kernel/sched/core.c:6765
__schedule_loop kernel/sched/core.c:6842 [inline]
schedule+0x14b/0x320 kernel/sched/core.c:6857
schedule_preempt_disabled+0x13/0x30 kernel/sched/core.c:6914
__mutex_lock_common kernel/locking/mutex.c:662 [inline]
__mutex_lock+0x817/0x1010 kernel/locking/mutex.c:730
blk_trace_setup+0xfb/0x1f0 kernel/trace/blktrace.c:631
sg_ioctl_common drivers/scsi/sg.c:1114 [inline]
sg_ioctl+0xa46/0x2e20 drivers/scsi/sg.c:1156
__do_compat_sys_ioctl fs/ioctl.c:1004 [inline]
__se_compat_sys_ioctl+0x502/0xc10 fs/ioctl.c:947
do_syscall_32_irqs_on arch/x86/entry/common.c:165 [inline]
__do_fast_syscall_32+0xb4/0x110 arch/x86/entry/common.c:387
do_fast_syscall_32+0x34/0x80 arch/x86/entry/common.c:412
entry_SYSENTER_compat_after_hwframe+0x84/0x8e
RIP: 0023:0xf7fb1579
RSP: 002b:00000000f509455c EFLAGS: 00000206 ORIG_RAX: 0000000000000036
RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 00000000c0481273
RDX: 0000000080000b40 RSI: 0000000000000000 RDI: 0000000000000000
RBP: 0000000000000000 R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000206 R12: 0000000000000000
R13: 0000000000000000 R14: 0000000000000000 R15: 0000000000000000
Showing all locks held in the system:
2 locks held by kworker/u8:0/12:
1 lock held by khungtaskd/31:
#0: ffffffff8eb393e0 (rcu_read_lock){....}-{1:3}, at: rcu_lock_acquire include/linux/rcupdate.h:337 [inline]
#0: ffffffff8eb393e0 (rcu_read_lock){....}-{1:3}, at: rcu_read_lock include/linux/rcupdate.h:849 [inline]
#0: ffffffff8eb393e0 (rcu_read_lock){....}-{1:3}, at: debug_show_all_locks+0x55/0x2a0 kernel/locking/lockdep.c:6746
1 lock held by udevd/5210:
2 locks held by getty/5592:
#0: ffff8880317dd0a0 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x25/0x70 drivers/tty/tty_ldisc.c:243
#1: ffffc9000330b2f0 (&ldata->atomic_read_lock){+.+.}-{4:4}, at: n_tty_read+0x616/0x1770 drivers/tty/n_tty.c:2211
3 locks held by kworker/1:9/14198:
#0: ffff888144eca548 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3213 [inline]
#0: ffff888144eca548 ((wq_completion)usb_hub_wq){+.+.}-{0:0}, at: process_scheduled_works+0x98b/0x18e0 kernel/workqueue.c:3319
#1: ffffc9000463fc60 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_one_work kernel/workqueue.c:3214 [inline]
#1: ffffc9000463fc60 ((work_completion)(&hub->events)){+.+.}-{0:0}, at: process_scheduled_works+0x9c6/0x18e0 kernel/workqueue.c:3319
#2: ffff888145f11190 (&dev->mutex){....}-{4:4}, at: device_lock include/linux/device.h:1030 [inline]
#2: ffff888145f11190 (&dev->mutex){....}-{4:4}, at: hub_event+0x1fe/0x5150 drivers/usb/core/hub.c:5861
2 locks held by kworker/u8:10/17738:
3 locks held by syz.1.2717/17747:
1 lock held by syz.2.2727/17779:
#0: ffff88802578ed98 (&q->debugfs_mutex){+.+.}-{4:4}, at: blk_trace_setup+0xfb/0x1f0 kernel/trace/blktrace.c:631
2 locks held by syz.9.2865/18416:
#0: ffff88802578a418 (&q->debugfs_mutex){+.+.}-{4:4}, at: compat_blk_trace_setup kernel/trace/blktrace.c:666 [inline]
#0: ffff88802578a418 (&q->debugfs_mutex){+.+.}-{4:4}, at: blk_trace_ioctl+0x4d6/0x830 kernel/trace/blktrace.c:735
#1: ffffffff8eb8bde8 (relay_channels_mutex){+.+.}-{4:4}, at: relay_open+0x3cb/0x950 kernel/relay.c:515
2 locks held by syz.5.3207/20042:
#0: ffff88807851a008 (&sb->s_type->i_mutex_key#10){+.+.}-{4:4}, at: inode_lock include/linux/fs.h:877 [inline]
#0: ffff88807851a008 (&sb->s_type->i_mutex_key#10){+.+.}-{4:4}, at: __sock_release net/socket.c:646 [inline]
#0: ffff88807851a008 (&sb->s_type->i_mutex_key#10){+.+.}-{4:4}, at: sock_close+0x90/0x240 net/socket.c:1398
#1: ffffffff8eb3e8b8 (rcu_state.exp_mutex){+.+.}-{4:4}, at: exp_funnel_lock kernel/rcu/tree_exp.h:302 [inline]
#1: ffffffff8eb3e8b8 (rcu_state.exp_mutex){+.+.}-{4:4}, at: synchronize_rcu_expedited+0x381/0x820 kernel/rcu/tree_exp.h:996
1 lock held by syz.0.3210/20066:
#0: ffffffff8eb3e780 (rcu_state.barrier_mutex){+.+.}-{4:4}, at: rcu_barrier+0x4c/0x530 kernel/rcu/tree.c:3741
1 lock held by dhcpcd-run-hook/20091:
#0: ffff8880b863e958 (&rq->__lock){-.-.}-{2:2}, at: raw_spin_rq_lock_nested+0xb0/0x140 kernel/sched/core.c:606
=============================================
NMI backtrace for cpu 0
CPU: 0 UID: 0 PID: 31 Comm: khungtaskd Not tainted 6.14.0-rc7-syzkaller-00205-g586de92313fc #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/12/2025
Call Trace:
__dump_stack lib/dump_stack.c:94 [inline]
dump_stack_lvl+0x241/0x360 lib/dump_stack.c:120
nmi_cpu_backtrace+0x49c/0x4d0 lib/nmi_backtrace.c:113
nmi_trigger_cpumask_backtrace+0x198/0x320 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:162 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:236 [inline]
watchdog+0x1058/0x10a0 kernel/hung_task.c:399
kthread+0x7a9/0x920 kernel/kthread.c:464
ret_from_fork+0x4b/0x80 arch/x86/kernel/process.c:148
ret_from_fork_asm+0x1a/0x30 arch/x86/entry/entry_64.S:244
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 UID: 0 PID: 5199 Comm: klogd Not tainted 6.14.0-rc7-syzkaller-00205-g586de92313fc #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/12/2025
RIP: 0010:kernel_text_address+0x0/0xe0 kernel/extable.c:95
Code: 48 39 d3 0f 92 c2 20 ca 08 c2 0f b6 c2 5b c3 cc cc cc cc 0f 1f 80 00 00 00 00 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 90 <66> 0f 1f 00 55 41 56 53 48 89 fb 48 c7 c0 00 00 00 81 bd 01 00 00
RSP: 0018:ffffc90002f476e8 EFLAGS: 00000246
RAX: 0000000000000000 RBX: ffffffff81a07d1c RCX: 0000000080000000
RDX: dffffc0000000000 RSI: ffffc90002f40000 RDI: ffffffff81a07d1c
RBP: ffffc90002f477b0 R08: ffffc90002f47ed8 R09: 0000000000000000
R10: ffffc90002f47770 R11: fffff520005e8ef0 R12: ffff88807b9cbc00
R13: ffffffff81ad6c00 R14: dffffc0000000000 R15: 1ffff920005e8eed
FS: 00007f985b8cd380(0000) GS:ffff8880b8700000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f82576e2440 CR3: 000000002f268000 CR4: 00000000003526f0
DR0: 000000000000000e DR1: 000000000000000c DR2: 000000000000000e
DR3: 00000000000000b4 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
__kernel_text_address+0xd/0x40 kernel/extable.c:79
unwind_get_return_address+0x4d/0x90 arch/x86/kernel/unwind_orc.c:369
arch_stack_walk+0xfd/0x150 arch/x86/kernel/stacktrace.c:26
stack_trace_save+0x118/0x1d0 kernel/stacktrace.c:122
kasan_save_stack mm/kasan/common.c:47 [inline]
kasan_save_track+0x3f/0x80 mm/kasan/common.c:68
kasan_save_free_info+0x40/0x50 mm/kasan/generic.c:576
poison_slab_object mm/kasan/common.c:247 [inline]
__kasan_slab_free+0x59/0x70 mm/kasan/common.c:264
kasan_slab_free include/linux/kasan.h:233 [inline]
slab_free_hook mm/slub.c:2353 [inline]
slab_free mm/slub.c:4609 [inline]
kfree+0x196/0x430 mm/slub.c:4757
syslog_print+0x59b/0x630 kernel/printk/printk.c:1699
do_syslog+0x3c2/0x820 kernel/printk/printk.c:1785
__do_sys_syslog kernel/printk/printk.c:1877 [inline]
__se_sys_syslog kernel/printk/printk.c:1875 [inline]
__x64_sys_syslog+0x7c/0x90 kernel/printk/printk.c:1875
do_syscall_x64 arch/x86/entry/common.c:52 [inline]
do_syscall_64+0xf3/0x230 arch/x86/entry/common.c:83
entry_SYSCALL_64_after_hwframe+0x77/0x7f
RIP: 0033:0x7f985ba2efa7
Code: 73 01 c3 48 8b 0d 81 ce 0c 00 f7 d8 64 89 01 48 83 c8 ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 44 00 00 b8 67 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d 51 ce 0c 00 f7 d8 64 89 01 48
RSP: 002b:00007ffce2fd9618 EFLAGS: 00000206 ORIG_RAX: 0000000000000067
RAX: ffffffffffffffda RBX: 00007f985bbcd4a0 RCX: 00007f985ba2efa7
RDX: 00000000000003ff RSI: 00007f985bbcd4a0 RDI: 0000000000000002
RBP: 0000000000000000 R08: 0000000000000007 R09: a9bda768e3711edd
R10: 0000000000004000 R11: 0000000000000206 R12: 00007f985bbcd4a0
R13: 00007f985bbbd212 R14: 00007f985bbcd877 R15: 00007f985bbcd877