INFO: task kworker/u5:5:3639 blocked for more than 143 seconds.
Not tainted 5.19.0-rc5-syzkaller-00056-ge35e5b6f695d #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/u5:5 state:D stack:24352 pid: 3639 ppid: 2 flags:0x00004000
Workqueue: hci8 hci_power_on
Call Trace:
context_switch kernel/sched/core.c:5146 [inline]
__schedule+0x957/0xe20 kernel/sched/core.c:6458
schedule+0xeb/0x1b0 kernel/sched/core.c:6530
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6589
__mutex_lock_common+0xecf/0x26c0 kernel/locking/mutex.c:679
__mutex_lock kernel/locking/mutex.c:747 [inline]
mutex_lock_nested+0x17/0x20 kernel/locking/mutex.c:799
hci_dev_do_open net/bluetooth/hci_core.c:480 [inline]
hci_power_on+0x178/0x650 net/bluetooth/hci_core.c:963
process_one_work+0x81c/0xd10 kernel/workqueue.c:2289
worker_thread+0xb14/0x1330 kernel/workqueue.c:2436
kthread+0x266/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30
INFO: task syz-executor.5:13864 blocked for more than 143 seconds.
Not tainted 5.19.0-rc5-syzkaller-00056-ge35e5b6f695d #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:27632 pid:13864 ppid: 3629 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:5146 [inline]
__schedule+0x957/0xe20 kernel/sched/core.c:6458
schedule+0xeb/0x1b0 kernel/sched/core.c:6530
schedule_timeout+0xac/0x300 kernel/time/timer.c:1911
do_wait_for_common+0x3ea/0x560 kernel/sched/completion.c:85
__wait_for_common kernel/sched/completion.c:106 [inline]
wait_for_common kernel/sched/completion.c:117 [inline]
wait_for_completion+0x46/0x60 kernel/sched/completion.c:138
__flush_work kernel/workqueue.c:3075 [inline]
__cancel_work_timer+0x585/0x740 kernel/workqueue.c:3162
hci_dev_close_sync+0x31/0xcc0 net/bluetooth/hci_sync.c:4091
hci_dev_do_close net/bluetooth/hci_core.c:553 [inline]
hci_unregister_dev+0x1b1/0x460 net/bluetooth/hci_core.c:2685
hci_uart_tty_close+0x1a7/0x280 drivers/bluetooth/hci_ldisc.c:548
tty_set_ldisc+0x22e/0x670 drivers/tty/tty_ldisc.c:552
tty_ioctl+0xada/0xc60 drivers/tty/tty_io.c:2714
vfs_ioctl fs/ioctl.c:51 [inline]
__do_sys_ioctl fs/ioctl.c:870 [inline]
__se_sys_ioctl+0xfb/0x170 fs/ioctl.c:856
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x2b/0x70 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x46/0xb0
RIP: 0033:0x7f1b92a89109
RSP: 002b:00007f1b919fe168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010
RAX: ffffffffffffffda RBX: 00007f1b92b9c030 RCX: 00007f1b92a89109
RDX: 0000000020000080 RSI: 0000000000005423 RDI: 0000000000000003
RBP: 00007f1b92ae305d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007ffd2900ec2f R14: 00007f1b919fe300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by khungtaskd/28:
#0: ffffffff8cb1e820 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
2 locks held by getty/3287:
#0: ffff8880276af098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:244
#1: ffffc90002d162e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6e8/0x1e50 drivers/tty/n_tty.c:2124
3 locks held by kworker/u5:5/3639:
#0: ffff888049500138 ((wq_completion)hci8){+.+.}-{0:0}, at: process_one_work+0x796/0xd10 kernel/workqueue.c:2262
#1: ffffc90003f4fd00 ((work_completion)(&hdev->power_on)){+.+.}-{0:0}, at: process_one_work+0x7d0/0xd10 kernel/workqueue.c:2264
#2: ffff88805e9a5048 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_open net/bluetooth/hci_core.c:480 [inline]
#2: ffff88805e9a5048 (&hdev->req_lock){+.+.}-{3:3}, at: hci_power_on+0x178/0x650 net/bluetooth/hci_core.c:963
3 locks held by syz-executor.5/13864:
#0: ffff88806de781c0 (&tty->legacy_mutex){+.+.}-{3:3}, at: tty_set_ldisc+0x4e/0x670 drivers/tty/tty_ldisc.c:529
#1: ffff88806de78098 (&tty->ldisc_sem){++++}-{0:0}, at: __tty_ldisc_lock drivers/tty/tty_ldisc.c:290 [inline]
#1: ffff88806de78098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_lock+0x6a/0xb0 drivers/tty/tty_ldisc.c:314
#2: ffff88805e9a5048 (&hdev->req_lock){+.+.}-{3:3}, at: hci_dev_do_close net/bluetooth/hci_core.c:551 [inline]
#2: ffff88805e9a5048 (&hdev->req_lock){+.+.}-{3:3}, at: hci_unregister_dev+0x1a9/0x460 net/bluetooth/hci_core.c:2685
=============================================
NMI backtrace for cpu 0
CPU: 0 PID: 28 Comm: khungtaskd Not tainted 5.19.0-rc5-syzkaller-00056-ge35e5b6f695d #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022
Call Trace:
__dump_stack lib/dump_stack.c:88 [inline]
dump_stack_lvl+0x1e3/0x2cb lib/dump_stack.c:106
nmi_cpu_backtrace+0x473/0x4a0 lib/nmi_backtrace.c:111
nmi_trigger_cpumask_backtrace+0x168/0x280 lib/nmi_backtrace.c:62
trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline]
check_hung_uninterruptible_tasks kernel/hung_task.c:212 [inline]
watchdog+0xcf9/0xd40 kernel/hung_task.c:369
kthread+0x266/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30
Sending NMI from CPU 0 to CPUs 1:
NMI backtrace for cpu 1
CPU: 1 PID: 21 Comm: ksoftirqd/1 Not tainted 5.19.0-rc5-syzkaller-00056-ge35e5b6f695d #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 06/29/2022
RIP: 0010:skb_release_head_state+0xae/0x250 net/core/skbuff.c:727
Code: c0 5c f9 43 80 7c 25 00 00 74 08 4c 89 ff e8 e9 ab af f9 49 c7 07 00 00 00 00 4d 8d 7e 60 4c 89 fb 48 c1 eb 03 42 80 3c 23 00 <74> 08 4c 89 ff e8 48 ab af f9 49 83 3f 00 74 3f 65 8b 2d b3 b1 d7
RSP: 0018:ffffc900001b7658 EFLAGS: 00000246
RAX: ffffffff882abd10 RBX: 1ffff1100f27694c RCX: ffff888011ff9d80
RDX: 0000000080000100 RSI: 0000000000000000 RDI: 0000000000000000
RBP: ffffc900001b7850 R08: ffffffff882abcd4 R09: fffffbfff1c0728e
R10: fffffbfff1c0728e R11: 1ffffffff1c0728d R12: dffffc0000000000
R13: 1ffff1100f27694b R14: ffff8880793b4a00 R15: ffff8880793b4a60
FS: 0000000000000000(0000) GS:ffff8880b9b00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 000000c00790ab20 CR3: 000000000c88e000 CR4: 00000000003506e0
DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400
Call Trace:
skb_release_all net/core/skbuff.c:740 [inline]
__kfree_skb+0x22/0x1d0 net/core/skbuff.c:756
__netif_receive_skb_core+0x354f/0x3c00 net/core/dev.c:5454
__netif_receive_skb_one_core net/core/dev.c:5478 [inline]
__netif_receive_skb+0x11a/0x500 net/core/dev.c:5594
process_backlog+0x4f8/0x8b0 net/core/dev.c:5922
__napi_poll+0xbe/0x4b0 net/core/dev.c:6488
napi_poll net/core/dev.c:6555 [inline]
net_rx_action+0x76c/0x10b0 net/core/dev.c:6666
__do_softirq+0x382/0x793 kernel/softirq.c:571
run_ksoftirqd+0xc1/0x120 kernel/softirq.c:934
smpboot_thread_fn+0x533/0x9d0 kernel/smpboot.c:164
kthread+0x266/0x300 kernel/kthread.c:376
ret_from_fork+0x1f/0x30
----------------
Code disassembly (best guess):
0: c0 5c f9 43 80 rcrb $0x80,0x43(%rcx,%rdi,8)
5: 7c 25 jl 0x2c
7: 00 00 add %al,(%rax)
9: 74 08 je 0x13
b: 4c 89 ff mov %r15,%rdi
e: e8 e9 ab af f9 callq 0xf9afabfc
13: 49 c7 07 00 00 00 00 movq $0x0,(%r15)
1a: 4d 8d 7e 60 lea 0x60(%r14),%r15
1e: 4c 89 fb mov %r15,%rbx
21: 48 c1 eb 03 shr $0x3,%rbx
25: 42 80 3c 23 00 cmpb $0x0,(%rbx,%r12,1)
* 2a: 74 08 je 0x34 <-- trapping instruction
2c: 4c 89 ff mov %r15,%rdi
2f: e8 48 ab af f9 callq 0xf9afab7c
34: 49 83 3f 00 cmpq $0x0,(%r15)
38: 74 3f je 0x79
3a: 65 gs
3b: 8b .byte 0x8b
3c: 2d .byte 0x2d
3d: b3 b1 mov $0xb1,%bl
3f: d7 xlat %ds:(%rbx)