INFO: task syz-executor.0:154483 blocked for more than 143 seconds. Not tainted 5.10.78 #1 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.0 state:D stack:27904 pid:154483 ppid:152278 flags:0x00000004 Call Trace: context_switch kernel/sched/core.c:3787 [inline] __schedule+0x84b/0x1e90 kernel/sched/core.c:4536 schedule+0xcb/0x270 kernel/sched/core.c:4614 schedule_preempt_disabled+0xc/0x20 kernel/sched/core.c:4673 __mutex_lock_common kernel/locking/mutex.c:1047 [inline] __mutex_lock+0x821/0x1310 kernel/locking/mutex.c:1109 perf_event_ctx_lock_nested+0x236/0x480 kernel/events/core.c:1356 perf_event_ctx_lock kernel/events/core.c:1369 [inline] perf_event_release_kernel+0x3a6/0xc20 kernel/events/core.c:5032 perf_release+0x33/0x40 kernel/events/core.c:5130 __fput+0x285/0x970 fs/file_table.c:281 task_work_run+0xe2/0x1a0 kernel/task_work.c:151 tracehook_notify_resume include/linux/tracehook.h:188 [inline] exit_to_user_mode_loop kernel/entry/common.c:164 [inline] exit_to_user_mode_prepare+0x155/0x160 kernel/entry/common.c:191 syscall_exit_to_user_mode+0x38/0x230 kernel/entry/common.c:266 entry_SYSCALL_64_after_hwframe+0x44/0xa9 RIP: 0033:0x7fdb502da72b RSP: 002b:00007ffd85590850 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000006 RCX: 00007fdb502da72b RDX: ffffffffffffffbc RSI: 0000000000000080 RDI: 0000000000000005 RBP: 0000000000000000 R08: 0000000000000000 R09: 00007fdb50440fe8 R10: 00007ffd85590940 R11: 0000000000000293 R12: 00000000002b8d63 R13: 00000000000003e8 R14: 00007fdb5043af60 R15: 00000000002b8d48 INFO: task syz-executor.0:154484 blocked for more than 143 seconds. Not tainted 5.10.78 #1 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.0 state:D stack:28864 pid:154484 ppid:152278 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:3787 [inline] __schedule+0x84b/0x1e90 kernel/sched/core.c:4536 schedule+0xcb/0x270 kernel/sched/core.c:4614 schedule_preempt_disabled+0xc/0x20 kernel/sched/core.c:4673 __mutex_lock_common kernel/locking/mutex.c:1047 [inline] __mutex_lock+0x821/0x1310 kernel/locking/mutex.c:1109 mutex_lock_double kernel/events/core.c:11619 [inline] __perf_event_ctx_lock_double kernel/events/core.c:11678 [inline] __do_sys_perf_event_open+0x1234/0x2c80 kernel/events/core.c:11948 do_syscall_64+0x33/0x40 arch/x86/entry/common.c:46 entry_SYSCALL_64_after_hwframe+0x44/0xa9 RIP: 0033:0x7fdb50327b19 RSP: 002b:00007fdb4d89d188 EFLAGS: 00000246 ORIG_RAX: 000000000000012a RAX: ffffffffffffffda RBX: 00007fdb5043af60 RCX: 00007fdb50327b19 RDX: 0000000000000000 RSI: 0000000000000619 RDI: 0000000020001d80 RBP: 00007fdb50381f6d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000003 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffd855907ef R14: 00007fdb4d89d300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/22: #0: ffffffff84df6720 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x269 kernel/locking/lockdep.c:6379 1 lock held by in:imklog/179: #0: ffff88800c9c0ff0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:930 1 lock held by syz-executor.0/154483: #0: ffff88800d7efcb0 (&ctx->mutex){+.+.}-{3:3}, at: perf_event_ctx_lock_nested+0x236/0x480 kernel/events/core.c:1356 3 locks held by syz-executor.0/154484: #0: ffff88802df2acd8 (&sig->exec_update_lock){++++}-{3:3}, at: __do_sys_perf_event_open+0xfbf/0x2c80 kernel/events/core.c:11930 #1: ffff88800d7efcb0 (&ctx->mutex){+.+.}-{3:3}, at: mutex_lock_double kernel/events/core.c:11618 [inline] #1: ffff88800d7efcb0 (&ctx->mutex){+.+.}-{3:3}, at: __perf_event_ctx_lock_double kernel/events/core.c:11678 [inline] #1: ffff88800d7efcb0 (&ctx->mutex){+.+.}-{3:3}, at: __do_sys_perf_event_open+0x1227/0x2c80 kernel/events/core.c:11948 #2: ffff88800d7efcb0 (&ctx->mutex/1){+.+.}-{3:3}, at: mutex_lock_double kernel/events/core.c:11619 [inline] #2: ffff88800d7efcb0 (&ctx->mutex/1){+.+.}-{3:3}, at: __perf_event_ctx_lock_double kernel/events/core.c:11678 [inline] #2: ffff88800d7efcb0 (&ctx->mutex/1){+.+.}-{3:3}, at: __do_sys_perf_event_open+0x1234/0x2c80 kernel/events/core.c:11948 2 locks held by systemd-udevd/154938: ============================================= audit: type=1326 audit(1636634621.507:2238): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.507:2239): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.509:2240): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.509:2241): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=202 compat=0 ip=0x7fb070f14b19 code=0x7ffc0000 audit: type=1326 audit(1636634621.510:2242): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.511:2243): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.511:2244): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.511:2245): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.511:2246): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 audit: type=1326 audit(1636634621.512:2247): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=164901 comm="syz-executor.0" exe="/syz-executor.0" sig=0 arch=c000003e syscall=1 compat=0 ip=0x7fb070ec75ff code=0x7ffc0000 Bluetooth: hci2: command 0x0401 tx timeout Bluetooth: hci2: command 0x0401 tx timeout Bluetooth: hci2: command 0x0401 tx timeout kauditd_printk_skb: 391 callbacks suppressed audit: type=1326 audit(1636634627.363:2639): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=165164 comm="syz-executor.0" exe="/syz-executor.0" sig=9 arch=c000003e syscall=231 compat=0 ip=0x7fb070f14b19 code=0x0 Bluetooth: hci2: command 0x0401 tx timeout audit: type=1326 audit(1636634628.503:2640): auid=0 uid=0 gid=0 ses=4 subj=system_u:system_r:kernel_t:s0 pid=165167 comm="syz-executor.0" exe="/syz-executor.0" sig=9 arch=c000003e syscall=231 compat=0 ip=0x7fb070f14b19 code=0x0