INFO: task hung in sock

Kernel	Title	Repro	Cause bisect	Fix bisect	Count	Last	Reported	Patched	Status
upstream	INFO: task hung in sock_ioctl (2) net				1	939d	939d	0/26	auto-closed as invalid on 2021/12/21 20:14
upstream	INFO: task hung in rtnetlink_rcv_msg net	C	inconclusive	inconclusive	913	37d	1882d	0/26	upstream: reported C repro on 2019/02/22 17:00
linux-4.14	INFO: task hung in sock_ioctl				1	1467d	1467d	0/1	auto-closed as invalid on 2020/08/10 12:43
upstream	INFO: task hung in sock_ioctl bridge				9	1921d	2278d	0/26	auto-closed as invalid on 2019/07/13 13:17

Bluetooth: hci3 command 0x0406 tx timeout Bluetooth: hci5 command 0x0406 tx timeout Bluetooth: hci1 command 0x0406 tx timeout Bluetooth: hci4 command 0x0406 tx timeout Bluetooth: hci0 command 0x0406 tx timeout INFO: task syz-executor.1:17084 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D28912 17084 8002 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 sock_ioctl+0x239/0x4c0 net/socket.c:1036 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f394f514188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056c0b0 RCX: 0000000000465b09 RDX: 0000000020000440 RSI: 00000000000089a0 RDI: 0000000000000005 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c0b0 R13: 00007ffdfba3360f R14: 00007f394f514300 R15: 0000000000022000 INFO: task syz-executor.1:17118 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D30344 17118 8002 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 sock_ioctl+0x239/0x4c0 net/socket.c:1036 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f394f4f3188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056c158 RCX: 0000000000465b09 RDX: 0000000020000300 RSI: 00000000000089a1 RDI: 0000000000000005 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c158 R13: 00007ffdfba3360f R14: 00007f394f4f3300 R15: 0000000000022000 INFO: task syz-executor.4:17070 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D28128 17070 8004 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 sock_ioctl+0x239/0x4c0 net/socket.c:1036 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f519fda0188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056bf60 RCX: 0000000000465b09 RDX: 0000000020000440 RSI: 00000000000089a0 RDI: 0000000000000006 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf60 R13: 00007ffda54ed7ef R14: 00007f519fda0300 R15: 0000000000022000 INFO: task syz-executor.4:17086 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D28912 17086 8004 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 sock_ioctl+0x239/0x4c0 net/socket.c:1036 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f519fd5e188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056c0b0 RCX: 0000000000465b09 RDX: 0000000020000300 RSI: 00000000000089a1 RDI: 0000000000000005 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c0b0 R13: 00007ffda54ed7ef R14: 00007f519fd5e300 R15: 0000000000022000 INFO: task syz-executor.4:17120 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D30344 17120 8004 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 sock_ioctl+0x239/0x4c0 net/socket.c:1036 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f519fd3d188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056c158 RCX: 0000000000465b09 RDX: 0000000020000440 RSI: 00000000000089a0 RDI: 0000000000000005 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c158 R13: 00007ffda54ed7ef R14: 00007f519fd3d300 R15: 0000000000022000 INFO: task syz-executor.4:17126 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D30120 17126 8004 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 sock_ioctl+0x239/0x4c0 net/socket.c:1036 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f519fd1c188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056c200 RCX: 0000000000465b09 RDX: 0000000020000440 RSI: 00000000000089a0 RDI: 0000000000000006 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c200 R13: 00007ffda54ed7ef R14: 00007f519fd1c300 R15: 0000000000022000 INFO: task syz-executor.4:17127 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D30120 17127 8004 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3384 schedule+0x8d/0x1b0 kernel/sched/core.c:3428 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3486 __mutex_lock_common kernel/locking/mutex.c:833 [inline] __mutex_lock+0x669/0x1310 kernel/locking/mutex.c:893 sock_ioctl+0x239/0x4c0 net/socket.c:1036 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f519fcfb188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056c2a8 RCX: 0000000000465b09 RDX: 0000000020000300 RSI: 00000000000089a1 RDI: 0000000000000006 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056c2a8 R13: 00007ffda54ed7ef R14: 00007f519fcfb300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1531: #0: (tasklist_lock){.+.?}, at: [<ffffffff86fedc17>] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548 1 lock held by syz-executor.1/17084: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 1 lock held by syz-executor.1/17118: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 1 lock held by syz-executor.4/17070: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 2 locks held by syz-executor.4/17080: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 #1: (rcu_preempt_state.barrier_mutex){+.+.}, at: [<ffffffff81469226>] _rcu_barrier+0x56/0x3b0 kernel/rcu/tree.c:3546 1 lock held by syz-executor.4/17086: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 1 lock held by syz-executor.4/17120: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 1 lock held by syz-executor.4/17126: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 1 lock held by syz-executor.4/17127: #0: (br_ioctl_mutex){+.+.}, at: [<ffffffff85ba7509>] sock_ioctl+0x239/0x4c0 net/socket.c:1036 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1531 Comm: khungtaskd Not tainted 4.14.218-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x180 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline] watchdog+0x5b9/0xb40 kernel/hung_task.c:274 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 16991 Comm: syz-executor.5 Not tainted 4.14.218-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 task: ffff8880ab7aa480 task.stack: ffff888065468000 RIP: 0010:check_preemption_disabled+0x40/0x240 lib/smp_processor_id.c:53 RSP: 0000:ffff88806546fca8 EFLAGS: 00000297 RAX: 0000000000000000 RBX: ffffffff893cff20 RCX: 0000000000000001 RDX: 0000000000000000 RSI: ffffffff87ccd640 RDI: ffffffff87ccd680 RBP: ffff8880ab7aa480 R08: 0000000000000000 R09: ffffed10156f5572 R10: 000000000000000b R11: ffff8880ab7aa480 R12: 0000000000000000 R13: ffff8880ab7aab90 R14: ffff88806546ff58 R15: 0000000000000000 FS: 00007f9782a03700(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007fff5bfa8daf CR3: 00000000aab6c000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: rcu_dynticks_curr_cpu_in_eqs kernel/rcu/tree.c:360 [inline] rcu_is_watching+0x11/0xb0 kernel/rcu/tree.c:1130 rcu_read_lock_sched_held+0xc6/0x1d0 kernel/rcu/update.c:111 trace_x86_fpu_regs_deactivated arch/x86/include/asm/trace/fpu.h:62 [inline] fpregs_deactivate arch/x86/include/asm/fpu/internal.h:511 [inline] fpu__drop+0x4a2/0x560 arch/x86/kernel/fpu/core.c:349 fpu__clear+0x33/0x3e0 arch/x86/kernel/fpu/core.c:387 handle_signal arch/x86/kernel/signal.c:765 [inline] do_signal+0xefe/0x1550 arch/x86/kernel/signal.c:816 exit_to_usermode_loop+0x160/0x200 arch/x86/entry/common.c:160 prepare_exit_to_usermode+0x1af/0x210 arch/x86/entry/common.c:199 retint_user+0x8/0x18 RIP: 0033:0x403e00 RSP: 002b:00007f9782a02c78 EFLAGS: 00000206 RAX: 0000000000000000 RBX: 000000000056c010 RCX: 00000000004b0f95 RDX: 00007f9782a02c80 RSI: 00007f9782a02db0 RDI: 000000000000000b RBP: 000000000056c008 R08: 0000000000000467 R09: 000000000000000e R10: 0019f38c4f65ed8c R11: 0000000000000001 R12: 000000000056c014 R13: 00007fff5bfa8daf R14: 00007f9782a03300 R15: 0000000000022000 Code: 65 44 8b 25 23 51 e9 7c 65 8b 05 fc ae e9 7c a9 ff ff ff 7f 74 18 e8 80 ee 3c fe e8 7b ee 3c fe 44 89 e0 5b 5d 41 5c 41 5d 41 5e <41> 5f c3 e8 68 ee 3c fe 48 c7 c0 80 92 f0 88 48 ba 00 00 00 00