INFO: task kworker/0:5:8078 blocked for more than 143 seconds.
Not tainted 5.16.0-rc1-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:kworker/0:5 state:D stack:24176 pid: 8078 ppid: 2 flags:0x00004000
Workqueue: events ovs_dp_masks_rebalance
Call Trace:
context_switch kernel/sched/core.c:4972 [inline]
__schedule+0xb72/0x1460 kernel/sched/core.c:6253
schedule+0x12b/0x1f0 kernel/sched/core.c:6326
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6385
__mutex_lock_common+0xd1f/0x2590 kernel/locking/mutex.c:680
__mutex_lock kernel/locking/mutex.c:740 [inline]
mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:792
ovs_lock net/openvswitch/datapath.c:106 [inline]
ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
process_one_work+0x853/0x1140 kernel/workqueue.c:2298
worker_thread+0xac1/0x1320 kernel/workqueue.c:2445
kthread+0x468/0x490 kernel/kthread.c:327
ret_from_fork+0x1f/0x30
INFO: task syz-executor.5:4092 blocked for more than 143 seconds.
Not tainted 5.16.0-rc1-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:23984 pid: 4092 ppid: 3346 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4972 [inline]
__schedule+0xb72/0x1460 kernel/sched/core.c:6253
schedule+0x12b/0x1f0 kernel/sched/core.c:6326
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6385
__mutex_lock_common+0xd1f/0x2590 kernel/locking/mutex.c:680
__mutex_lock kernel/locking/mutex.c:740 [inline]
mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:792
ovs_lock net/openvswitch/datapath.c:106 [inline]
ovs_dp_cmd_new+0x738/0xeb0 net/openvswitch/datapath.c:1783
genl_family_rcv_msg_doit net/netlink/genetlink.c:731 [inline]
genl_family_rcv_msg net/netlink/genetlink.c:775 [inline]
genl_rcv_msg+0x1032/0x1480 net/netlink/genetlink.c:792
netlink_rcv_skb+0x200/0x470 net/netlink/af_netlink.c:2491
genl_rcv+0x24/0x40 net/netlink/genetlink.c:803
netlink_unicast_kernel net/netlink/af_netlink.c:1319 [inline]
netlink_unicast+0x814/0x9f0 net/netlink/af_netlink.c:1345
netlink_sendmsg+0xa20/0xe40 net/netlink/af_netlink.c:1916
sock_sendmsg_nosec net/socket.c:704 [inline]
sock_sendmsg net/socket.c:724 [inline]
____sys_sendmsg+0x5b9/0x910 net/socket.c:2409
___sys_sendmsg net/socket.c:2463 [inline]
__sys_sendmsg+0x280/0x370 net/socket.c:2492
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x44/0xd0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f4e10db8ae9
RSP: 002b:00007f4e0e32e188 EFLAGS: 00000246 ORIG_RAX: 000000000000002e
RAX: ffffffffffffffda RBX: 00007f4e10ecbf60 RCX: 00007f4e10db8ae9
RDX: 0200000000000000 RSI: 0000000020000180 RDI: 0000000000000003
RBP: 00007f4e10e12f6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffe0af524f R14: 00007f4e0e32e300 R15: 0000000000022000
INFO: task syz-executor.5:4095 blocked for more than 143 seconds.
Not tainted 5.16.0-rc1-syzkaller #0
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
task:syz-executor.5 state:D stack:23984 pid: 4095 ppid: 3346 flags:0x00004004
Call Trace:
context_switch kernel/sched/core.c:4972 [inline]
__schedule+0xb72/0x1460 kernel/sched/core.c:6253
schedule+0x12b/0x1f0 kernel/sched/core.c:6326
schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6385
__mutex_lock_common+0xd1f/0x2590 kernel/locking/mutex.c:680
__mutex_lock kernel/locking/mutex.c:740 [inline]
mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:792
ovs_lock net/openvswitch/datapath.c:106 [inline]
ovs_dp_cmd_new+0x738/0xeb0 net/openvswitch/datapath.c:1783
genl_family_rcv_msg_doit net/netlink/genetlink.c:731 [inline]
genl_family_rcv_msg net/netlink/genetlink.c:775 [inline]
genl_rcv_msg+0x1032/0x1480 net/netlink/genetlink.c:792
netlink_rcv_skb+0x200/0x470 net/netlink/af_netlink.c:2491
genl_rcv+0x24/0x40 net/netlink/genetlink.c:803
netlink_unicast_kernel net/netlink/af_netlink.c:1319 [inline]
netlink_unicast+0x814/0x9f0 net/netlink/af_netlink.c:1345
netlink_sendmsg+0xa20/0xe40 net/netlink/af_netlink.c:1916
sock_sendmsg_nosec net/socket.c:704 [inline]
sock_sendmsg net/socket.c:724 [inline]
____sys_sendmsg+0x5b9/0x910 net/socket.c:2409
___sys_sendmsg net/socket.c:2463 [inline]
__sys_sendmsg+0x280/0x370 net/socket.c:2492
do_syscall_x64 arch/x86/entry/common.c:50 [inline]
do_syscall_64+0x44/0xd0 arch/x86/entry/common.c:80
entry_SYSCALL_64_after_hwframe+0x44/0xae
RIP: 0033:0x7f4e10db8ae9
RSP: 002b:00007f4e0e30d188 EFLAGS: 00000246 ORIG_RAX: 000000000000002e
RAX: ffffffffffffffda RBX: 00007f4e10ecc020 RCX: 00007f4e10db8ae9
RDX: 0200000000000000 RSI: 0000000020000180 RDI: 0000000000000003
RBP: 00007f4e10e12f6d R08: 0000000000000000 R09: 0000000000000000
R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000
R13: 00007fffe0af524f R14: 00007f4e0e30d300 R15: 0000000000022000
Showing all locks held in the system:
1 lock held by khungtaskd/27:
#0: ffffffff8cd1da80 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30
3 locks held by kworker/0:2/135:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc900027afd20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
1 lock held by in:imklog/6171:
2 locks held by agetty/6223:
#0: ffff888022e09098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:252
#1: ffffc90002f232e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6c5/0x1c60 drivers/tty/n_tty.c:2113
3 locks held by kworker/0:5/8078:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc9000a107d20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
2 locks held by kworker/u4:5/8345:
3 locks held by kworker/1:1/23186:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc9000c6d7d20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
3 locks held by kworker/0:0/28003:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc90018087d20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
3 locks held by kworker/1:3/32054:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc90008ad7d20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
3 locks held by kworker/1:4/8754:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc9001849fd20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
3 locks held by kworker/1:0/30394:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc9000445fd20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
6 locks held by kworker/u4:6/20822:
#0: ffff888012572938 ((wq_completion)netns){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc90017f6fd20 (net_cleanup_work){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8dd75a70 (pernet_ops_rwsem){++++}-{3:3}, at: cleanup_net+0xf0/0xc50 net/core/net_namespace.c:555
#3: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#3: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_exit_net+0xdd/0x830 net/openvswitch/datapath.c:2606
#4: ffffffff8dd81808 (rtnl_mutex){+.+.}-{3:3}, at: internal_dev_destroy+0x6e/0xf0 net/openvswitch/vport-internal_dev.c:183
#5: ffffffff8cd222e8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: exp_funnel_lock kernel/rcu/tree_exp.h:290 [inline]
#5: ffffffff8cd222e8 (rcu_state.exp_mutex){+.+.}-{3:3}, at: synchronize_rcu_expedited+0x277/0x740 kernel/rcu/tree_exp.h:836
3 locks held by kworker/1:2/23153:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc90002b7fd20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
3 locks held by kworker/0:4/2881:
#0: ffff888011864d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc90004dafd20 ((work_completion)(&(&ovs_net->masks_rebalance)->work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#2: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_masks_rebalance+0x29/0xe0 net/openvswitch/datapath.c:2458
2 locks held by kworker/0:7/3208:
#0: ffff888011866538 ((wq_completion)rcu_gp){+.+.}-{0:0}, at: process_one_work+0x7ca/0x1140
#1: ffffc90004e4fd20 ((work_completion)(&rew.rew_work)){+.+.}-{0:0}, at: process_one_work+0x808/0x1140 kernel/workqueue.c:2273
2 locks held by syz-executor.4/4069:
#0: ffffffff8dde1150 (cb_lock){++++}-{3:3}, at: genl_rcv+0x15/0x40 net/netlink/genetlink.c:802
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_cmd_new+0x738/0xeb0 net/openvswitch/datapath.c:1783
2 locks held by syz-executor.5/4092:
#0: ffffffff8dde1150 (cb_lock){++++}-{3:3}, at: genl_rcv+0x15/0x40 net/netlink/genetlink.c:802
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_cmd_new+0x738/0xeb0 net/openvswitch/datapath.c:1783
2 locks held by syz-executor.5/4095:
#0: ffffffff8dde1150 (cb_lock){++++}-{3:3}, at: genl_rcv+0x15/0x40 net/netlink/genetlink.c:802
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_cmd_new+0x738/0xeb0 net/openvswitch/datapath.c:1783
2 locks held by syz-executor.1/4816:
#0: ffffffff8dde1150 (cb_lock){++++}-{3:3}, at: genl_rcv+0x15/0x40 net/netlink/genetlink.c:802
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_lock net/openvswitch/datapath.c:106 [inline]
#1: ffffffff8e06ede8 (ovs_mutex){+.+.}-{3:3}, at: ovs_dp_cmd_new+0x738/0xeb0 net/openvswitch/datapath.c:1783
=============================================
NMI backtrace for cpu 1
CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.16.0-rc1-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+0x1dc/0x2d8 lib/dump_stack.c:106
nmi_cpu_backtrace+0x45f/0x490 lib/nmi_backtrace.c:105
nmi_trigger_cpumask_backtrace+0x16a/0x280 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+0xc82/0xcd0 kernel/hung_task.c:295
kthread+0x468/0x490 kernel/kthread.c:327
ret_from_fork+0x1f/0x30
Sending NMI from CPU 1 to CPUs 0:
NMI backtrace for cpu 0
CPU: 0 PID: 10518 Comm: kworker/u4:7 Not tainted 5.16.0-rc1-syzkaller #0
Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011
Workqueue: 0x0 (phy25)
RIP: 0010:lookup_object lib/debugobjects.c:198 [inline]
RIP: 0010:debug_object_deactivate+0xac/0x400 lib/debugobjects.c:737
Code: 1b 45 31 f6 eb 0e 0f 1f 84 00 00 00 00 00 41 ff c6 48 8b 1b 48 85 db 74 38 4c 8d 7b 18 4d 89 fd 49 c1 ed 03 43 80 7c 25 00 00 <74> 08 4c 89 ff e8 aa 63 b5 fd 49 39 2f 74 7d 48 89 d8 48 c1 e8 03
RSP: 0018:ffffc900038efc10 EFLAGS: 00000046
RAX: 1ffff11014b44dc7 RBX: ffff8880b1d6e700 RCX: 0000000000000001
RDX: dffffc0000000000 RSI: 0000000000000004 RDI: ffffc900038efae0
RBP: ffff88817bf597c8 R08: dffffc0000000000 R09: 0000000000000003
R10: fffff5200071df5d R11: 0000000000000004 R12: dffffc0000000000
R13: 1ffff110163adce3 R14: 0000000000000011 R15: ffff8880b1d6e718
FS: 0000000000000000(0000) GS:ffff8880b9a00000(0000) knlGS:0000000000000000
CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f21440050b8 CR3: 000000007e868000 CR4: 00000000003506f0
DR0: 0000800000000002 DR1: 0000000000000000 DR2: 0000000000000000
DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600
Call Trace:
debug_work_deactivate kernel/workqueue.c:514 [inline]
process_one_work+0x33e/0x1140 kernel/workqueue.c:2228
worker_thread+0xac1/0x1320 kernel/workqueue.c:2445
kthread+0x468/0x490 kernel/kthread.c:327
ret_from_fork+0x1f/0x30
----------------
Code disassembly (best guess), 1 bytes skipped:
0: 45 31 f6 xor %r14d,%r14d
3: eb 0e jmp 0x13
5: 0f 1f 84 00 00 00 00 nopl 0x0(%rax,%rax,1)
c: 00
d: 41 ff c6 inc %r14d
10: 48 8b 1b mov (%rbx),%rbx
13: 48 85 db test %rbx,%rbx
16: 74 38 je 0x50
18: 4c 8d 7b 18 lea 0x18(%rbx),%r15
1c: 4d 89 fd mov %r15,%r13
1f: 49 c1 ed 03 shr $0x3,%r13
23: 43 80 7c 25 00 00 cmpb $0x0,0x0(%r13,%r12,1)
* 29: 74 08 je 0x33 <-- trapping instruction
2b: 4c 89 ff mov %r15,%rdi
2e: e8 aa 63 b5 fd callq 0xfdb563dd
33: 49 39 2f cmp %rbp,(%r15)
36: 74 7d je 0xb5
38: 48 89 d8 mov %rbx,%rax
3b: 48 c1 e8 03 shr $0x3,%rax