INFO: task syz-executor.2:10266 blocked for more than 143 seconds. Not tainted 5.14.0-rc3-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.2 state:D stack:28176 pid:10266 ppid: 8810 flags:0x00000000 Call Trace: context_switch kernel/sched/core.c:4683 [inline] __schedule+0x93a/0x26f0 kernel/sched/core.c:5940 schedule+0xd3/0x270 kernel/sched/core.c:6019 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078 __mutex_lock_common kernel/locking/mutex.c:1036 [inline] __mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104 sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 __sys_connect_file+0x155/0x1a0 net/socket.c:1879 __sys_connect+0x161/0x190 net/socket.c:1896 __do_sys_connect net/socket.c:1906 [inline] __se_sys_connect net/socket.c:1903 [inline] __x64_sys_connect+0x6f/0xb0 net/socket.c:1903 do_syscall_x64 arch/x86/entry/common.c:50 [inline] do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 entry_SYSCALL_64_after_hwframe+0x44/0xae RIP: 0033:0x4665d9 RSP: 002b:00007f6dd9f6b188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9 RDX: 0000000000000080 RSI: 0000000020000080 RDI: 0000000000000006 RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 R13: 00007ffd9304140f R14: 00007f6dd9f6b300 R15: 0000000000022000 INFO: task syz-executor.3:10271 blocked for more than 143 seconds. Not tainted 5.14.0-rc3-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.3 state:D stack:27528 pid:10271 ppid: 8811 flags:0x00000000 Call Trace: context_switch kernel/sched/core.c:4683 [inline] __schedule+0x93a/0x26f0 kernel/sched/core.c:5940 schedule+0xd3/0x270 kernel/sched/core.c:6019 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078 __mutex_lock_common kernel/locking/mutex.c:1036 [inline] __mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104 sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 __sys_connect_file+0x155/0x1a0 net/socket.c:1879 __sys_connect+0x161/0x190 net/socket.c:1896 __do_sys_connect net/socket.c:1906 [inline] __se_sys_connect net/socket.c:1903 [inline] __x64_sys_connect+0x6f/0xb0 net/socket.c:1903 do_syscall_x64 arch/x86/entry/common.c:50 [inline] do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 entry_SYSCALL_64_after_hwframe+0x44/0xae RIP: 0033:0x4665d9 RSP: 002b:00007fa247894188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9 RDX: 0000000000000080 RSI: 0000000020000080 RDI: 0000000000000006 RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 R13: 00007fff191fe8bf R14: 00007fa247894300 R15: 0000000000022000 INFO: task syz-executor.5:10280 blocked for more than 143 seconds. Not tainted 5.14.0-rc3-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.5 state:D stack:28176 pid:10280 ppid: 8813 flags:0x00000004 Call Trace: context_switch kernel/sched/core.c:4683 [inline] __schedule+0x93a/0x26f0 kernel/sched/core.c:5940 schedule+0xd3/0x270 kernel/sched/core.c:6019 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078 __mutex_lock_common kernel/locking/mutex.c:1036 [inline] __mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104 sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 __sys_connect_file+0x155/0x1a0 net/socket.c:1879 __sys_connect+0x161/0x190 net/socket.c:1896 __do_sys_connect net/socket.c:1906 [inline] __se_sys_connect net/socket.c:1903 [inline] __x64_sys_connect+0x6f/0xb0 net/socket.c:1903 do_syscall_x64 arch/x86/entry/common.c:50 [inline] do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 entry_SYSCALL_64_after_hwframe+0x44/0xae RIP: 0033:0x4665d9 RSP: 002b:00007f99b29e8188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9 RDX: 0000000000000080 RSI: 0000000020000080 RDI: 0000000000000006 RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 R13: 00007ffd50f0436f R14: 00007f99b29e8300 R15: 0000000000022000 INFO: task syz-executor.3:10293 blocked for more than 143 seconds. Not tainted 5.14.0-rc3-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.3 state:D stack:28176 pid:10293 ppid: 8811 flags:0x00000000 Call Trace: context_switch kernel/sched/core.c:4683 [inline] __schedule+0x93a/0x26f0 kernel/sched/core.c:5940 schedule+0xd3/0x270 kernel/sched/core.c:6019 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078 __mutex_lock_common kernel/locking/mutex.c:1036 [inline] __mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104 sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 __sys_connect_file+0x155/0x1a0 net/socket.c:1879 __sys_connect+0x161/0x190 net/socket.c:1896 __do_sys_connect net/socket.c:1906 [inline] __se_sys_connect net/socket.c:1903 [inline] __x64_sys_connect+0x6f/0xb0 net/socket.c:1903 do_syscall_x64 arch/x86/entry/common.c:50 [inline] do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 entry_SYSCALL_64_after_hwframe+0x44/0xae RIP: 0033:0x4665d9 RSP: 002b:00007fa247894188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9 RDX: 0000000000000080 RSI: 0000000020000080 RDI: 0000000000000006 RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 R13: 00007fff191fe8bf R14: 00007fa247894300 R15: 0000000000022000 INFO: task syz-executor.1:10306 blocked for more than 144 seconds. Not tainted 5.14.0-rc3-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.1 state:D stack:27528 pid:10306 ppid: 8812 flags:0x00000004 Call Trace: context_switch kernel/sched/core.c:4683 [inline] __schedule+0x93a/0x26f0 kernel/sched/core.c:5940 schedule+0xd3/0x270 kernel/sched/core.c:6019 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6078 __mutex_lock_common kernel/locking/mutex.c:1036 [inline] __mutex_lock+0x7b6/0x10a0 kernel/locking/mutex.c:1104 sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 __sys_connect_file+0x155/0x1a0 net/socket.c:1879 __sys_connect+0x161/0x190 net/socket.c:1896 __do_sys_connect net/socket.c:1906 [inline] __se_sys_connect net/socket.c:1903 [inline] __x64_sys_connect+0x6f/0xb0 net/socket.c:1903 do_syscall_x64 arch/x86/entry/common.c:50 [inline] do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 entry_SYSCALL_64_after_hwframe+0x44/0xae RIP: 0033:0x4665d9 RSP: 002b:00007f19e1af9188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a RAX: ffffffffffffffda RBX: 000000000056bf80 RCX: 00000000004665d9 RDX: 0000000000000080 RSI: 0000000020000080 RDI: 0000000000000006 RBP: 00000000004bfcb9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 R13: 00007ffe520f021f R14: 00007f19e1af9300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1553: #0: ffffffff8b97ba40 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6446 1 lock held by in:imklog/8142: #0: ffff888017bca0f0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:974 1 lock held by syz-executor.0/10257: #0: ffff88802a8b8078 (&hdev->lock){+.+.}-{3:3}, at: sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 1 lock held by syz-executor.2/10266: #0: ffff88802a8b8078 (&hdev->lock){+.+.}-{3:3}, at: sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 1 lock held by syz-executor.3/10271: #0: ffff88802a8b8078 (&hdev->lock){+.+.}-{3:3}, at: sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 1 lock held by syz-executor.5/10280: #0: ffff88802a8b8078 (&hdev->lock){+.+.}-{3:3}, at: sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 1 lock held by syz-executor.3/10293: #0: ffff88802a8b8078 (&hdev->lock){+.+.}-{3:3}, at: sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 1 lock held by syz-executor.1/10306: #0: ffff88802a8b8078 (&hdev->lock){+.+.}-{3:3}, at: sco_sock_connect+0x1ab/0xa20 net/bluetooth/sco.c:589 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 1553 Comm: khungtaskd Not tainted 5.14.0-rc3-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:88 [inline] dump_stack_lvl+0xcd/0x134 lib/dump_stack.c:105 nmi_cpu_backtrace.cold+0x44/0xd7 lib/nmi_backtrace.c:105 nmi_trigger_cpumask_backtrace+0x1b3/0x230 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:210 [inline] watchdog+0xd0a/0xfc0 kernel/hung_task.c:295 kthread+0x3e5/0x4d0 kernel/kthread.c:319 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295 Sending NMI from CPU 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 4865 Comm: systemd-journal Not tainted 5.14.0-rc3-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 RIP: 0010:mark_usage kernel/locking/lockdep.c:4514 [inline] RIP: 0010:__lock_acquire+0x89c/0x54a0 kernel/locking/lockdep.c:4969 Code: 00 00 41 8b b5 d0 09 00 00 85 f6 74 18 ba 06 00 00 00 4c 89 e6 4c 89 ef e8 e1 da ff ff 85 c0 0f 84 8f 05 00 00 ba 08 00 00 00 <4c> 89 e6 4c 89 ef e8 c9 da ff ff 85 c0 0f 84 77 05 00 00 48 c7 c2 RSP: 0018:ffffc9000167f498 EFLAGS: 00000046 RAX: 0000000000000000 RBX: ffff8880159d09d4 RCX: 1ffff11002b3a13d RDX: 0000000000000008 RSI: 0000000000000000 RDI: ffffffff8fcb9b79 RBP: 0000000000000004 R08: 0000000000000000 R09: ffffffff8fcb78a7 R10: 0000000000000000 R11: 0000000000086088 R12: ffff8880159d09f0 R13: ffff8880159d0000 R14: 0000000000000000 R15: 0000000000000002 FS: 00007f459ece38c0(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f459c10a000 CR3: 000000002d434000 CR4: 0000000000350ee0 Call Trace: lock_acquire kernel/locking/lockdep.c:5625 [inline] lock_acquire+0x1ab/0x510 kernel/locking/lockdep.c:5590 rcu_lock_acquire include/linux/rcupdate.h:267 [inline] rcu_read_lock include/linux/rcupdate.h:687 [inline] is_bpf_text_address+0x36/0x170 kernel/bpf/core.c:704 kernel_text_address kernel/extable.c:151 [inline] kernel_text_address+0xbd/0xf0 kernel/extable.c:120 __kernel_text_address+0x9/0x30 kernel/extable.c:105 unwind_get_return_address arch/x86/kernel/unwind_orc.c:318 [inline] unwind_get_return_address+0x51/0x90 arch/x86/kernel/unwind_orc.c:313 arch_stack_walk+0x93/0xe0 arch/x86/kernel/stacktrace.c:26 stack_trace_save+0x8c/0xc0 kernel/stacktrace.c:121 kasan_save_stack+0x1b/0x40 mm/kasan/common.c:38 kasan_record_aux_stack+0xe5/0x110 mm/kasan/generic.c:348 task_work_add+0x3a/0x190 kernel/task_work.c:38 fput_many.part.0+0xbb/0x170 fs/file_table.c:341 fput_many fs/file_table.c:336 [inline] fput+0x3b/0x50 fs/file_table.c:357 path_openat+0x19bd/0x27f0 fs/namei.c:3516 do_filp_open+0x1aa/0x400 fs/namei.c:3534 do_sys_openat2+0x16d/0x420 fs/open.c:1204 do_sys_open fs/open.c:1220 [inline] __do_sys_open fs/open.c:1228 [inline] __se_sys_open fs/open.c:1224 [inline] __x64_sys_open+0x119/0x1c0 fs/open.c:1224 do_syscall_x64 arch/x86/entry/common.c:50 [inline] do_syscall_64+0x35/0xb0 arch/x86/entry/common.c:80 entry_SYSCALL_64_after_hwframe+0x44/0xae RIP: 0033:0x7f459e272840 Code: 73 01 c3 48 8b 0d 68 77 20 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 83 3d 89 bb 20 00 00 75 10 b8 02 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 31 c3 48 83 ec 08 e8 1e f6 ff ff 48 89 04 24 RSP: 002b:00007ffc2c1c5968 EFLAGS: 00000246 ORIG_RAX: 0000000000000002 RAX: ffffffffffffffda RBX: 00007ffc2c1c5c70 RCX: 00007f459e272840 RDX: 00000000000001a0 RSI: 0000000000080042 RDI: 000055b3e3bc26e0 RBP: 000000000000000d R08: 0000000000000000 R09: 00000000ffffffff R10: 0000000000000069 R11: 0000000000000246 R12: 00000000ffffffff R13: 000055b3e3bb7040 R14: 00007ffc2c1c5c30 R15: 000055b3e3bc2500