INFO: task syz-executor.1:13805 can't die for more than 143 seconds. task:syz-executor.1 state:D stack:28976 pid:13805 ppid: 6541 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4965 [inline] __schedule+0xa9a/0x4940 kernel/sched/core.c:6246 schedule+0xd2/0x260 kernel/sched/core.c:6319 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378 __mutex_lock_common kernel/locking/mutex.c:672 [inline] __mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732 __pipe_lock fs/pipe.c:102 [inline] pipe_write+0x633/0x1c00 fs/pipe.c:570 call_write_iter include/linux/fs.h:2161 [inline] new_sync_write+0x429/0x660 fs/read_write.c:507 vfs_write+0x7cd/0xae0 fs/read_write.c:594 ksys_write+0x1ee/0x250 fs/read_write.c:647 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:0x7f3d105fca39 RSP: 002b:00007f3d0db72188 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 00007f3d106fff60 RCX: 00007f3d105fca39 RDX: 00000000fffffecc RSI: 0000000020000000 RDI: 0000000000000004 RBP: 00007f3d10656c5f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffdde39a32f R14: 00007f3d0db72300 R15: 0000000000022000 INFO: task syz-executor.1:13805 blocked for more than 143 seconds. Not tainted 5.15.0-rc6-next-20211020-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.1 state:D stack:28976 pid:13805 ppid: 6541 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4965 [inline] __schedule+0xa9a/0x4940 kernel/sched/core.c:6246 schedule+0xd2/0x260 kernel/sched/core.c:6319 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378 __mutex_lock_common kernel/locking/mutex.c:672 [inline] __mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732 __pipe_lock fs/pipe.c:102 [inline] pipe_write+0x633/0x1c00 fs/pipe.c:570 call_write_iter include/linux/fs.h:2161 [inline] new_sync_write+0x429/0x660 fs/read_write.c:507 vfs_write+0x7cd/0xae0 fs/read_write.c:594 ksys_write+0x1ee/0x250 fs/read_write.c:647 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:0x7f3d105fca39 RSP: 002b:00007f3d0db72188 EFLAGS: 00000246 ORIG_RAX: 0000000000000001 RAX: ffffffffffffffda RBX: 00007f3d106fff60 RCX: 00007f3d105fca39 RDX: 00000000fffffecc RSI: 0000000020000000 RDI: 0000000000000004 RBP: 00007f3d10656c5f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffdde39a32f R14: 00007f3d0db72300 R15: 0000000000022000 INFO: task syz-executor.1:13810 can't die for more than 143 seconds. task:syz-executor.1 state:D stack:27528 pid:13810 ppid: 6541 flags:0x00000004 Call Trace: context_switch kernel/sched/core.c:4965 [inline] __schedule+0xa9a/0x4940 kernel/sched/core.c:6246 schedule+0xd2/0x260 kernel/sched/core.c:6319 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378 __mutex_lock_common kernel/locking/mutex.c:672 [inline] __mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732 rtnl_lock net/core/rtnetlink.c:72 [inline] rtnetlink_rcv_msg+0x3be/0xb80 net/core/rtnetlink.c:5569 netlink_rcv_skb+0x153/0x420 net/netlink/af_netlink.c:2491 netlink_unicast_kernel net/netlink/af_netlink.c:1319 [inline] netlink_unicast+0x533/0x7d0 net/netlink/af_netlink.c:1345 netlink_sendmsg+0x86d/0xda0 net/netlink/af_netlink.c:1916 sock_sendmsg_nosec net/socket.c:704 [inline] sock_sendmsg+0xcf/0x120 net/socket.c:724 sock_no_sendpage+0xf6/0x140 net/core/sock.c:3080 kernel_sendpage.part.0+0x1a0/0x340 net/socket.c:3504 kernel_sendpage net/socket.c:3501 [inline] sock_sendpage+0xe5/0x140 net/socket.c:1003 pipe_to_sendpage+0x2ad/0x380 fs/splice.c:364 splice_from_pipe_feed fs/splice.c:418 [inline] __splice_from_pipe+0x43e/0x8a0 fs/splice.c:562 splice_from_pipe fs/splice.c:597 [inline] generic_splice_sendpage+0xd4/0x140 fs/splice.c:746 do_splice_from fs/splice.c:767 [inline] do_splice+0xb7e/0x1960 fs/splice.c:1079 __do_splice+0x134/0x250 fs/splice.c:1144 __do_sys_splice fs/splice.c:1350 [inline] __se_sys_splice fs/splice.c:1332 [inline] __x64_sys_splice+0x198/0x250 fs/splice.c:1332 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:0x7f3d105fca39 RSP: 002b:00007f3d0db51188 EFLAGS: 00000246 ORIG_RAX: 0000000000000113 RAX: ffffffffffffffda RBX: 00007f3d10700020 RCX: 00007f3d105fca39 RDX: 0000000000000005 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00007f3d10656c5f R08: 000000000004ffe2 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffdde39a32f R14: 00007f3d0db51300 R15: 0000000000022000 INFO: task syz-executor.1:13810 blocked for more than 144 seconds. Not tainted 5.15.0-rc6-next-20211020-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.1 state:D stack:27528 pid:13810 ppid: 6541 flags:0x00000004 Call Trace: context_switch kernel/sched/core.c:4965 [inline] __schedule+0xa9a/0x4940 kernel/sched/core.c:6246 schedule+0xd2/0x260 kernel/sched/core.c:6319 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6378 __mutex_lock_common kernel/locking/mutex.c:672 [inline] __mutex_lock+0xa32/0x12f0 kernel/locking/mutex.c:732 rtnl_lock net/core/rtnetlink.c:72 [inline] rtnetlink_rcv_msg+0x3be/0xb80 net/core/rtnetlink.c:5569 netlink_rcv_skb+0x153/0x420 net/netlink/af_netlink.c:2491 netlink_unicast_kernel net/netlink/af_netlink.c:1319 [inline] netlink_unicast+0x533/0x7d0 net/netlink/af_netlink.c:1345 netlink_sendmsg+0x86d/0xda0 net/netlink/af_netlink.c:1916 sock_sendmsg_nosec net/socket.c:704 [inline] sock_sendmsg+0xcf/0x120 net/socket.c:724 sock_no_sendpage+0xf6/0x140 net/core/sock.c:3080 kernel_sendpage.part.0+0x1a0/0x340 net/socket.c:3504 kernel_sendpage net/socket.c:3501 [inline] sock_sendpage+0xe5/0x140 net/socket.c:1003 pipe_to_sendpage+0x2ad/0x380 fs/splice.c:364 splice_from_pipe_feed fs/splice.c:418 [inline] __splice_from_pipe+0x43e/0x8a0 fs/splice.c:562 splice_from_pipe fs/splice.c:597 [inline] generic_splice_sendpage+0xd4/0x140 fs/splice.c:746 do_splice_from fs/splice.c:767 [inline] do_splice+0xb7e/0x1960 fs/splice.c:1079 __do_splice+0x134/0x250 fs/splice.c:1144 __do_sys_splice fs/splice.c:1350 [inline] __se_sys_splice fs/splice.c:1332 [inline] __x64_sys_splice+0x198/0x250 fs/splice.c:1332 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:0x7f3d105fca39 RSP: 002b:00007f3d0db51188 EFLAGS: 00000246 ORIG_RAX: 0000000000000113 RAX: ffffffffffffffda RBX: 00007f3d10700020 RCX: 00007f3d105fca39 RDX: 0000000000000005 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00007f3d10656c5f R08: 000000000004ffe2 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffdde39a32f R14: 00007f3d0db51300 R15: 0000000000022000 INFO: task syz-executor.0:13804 can't die for more than 144 seconds. task:syz-executor.0 state:D stack:26440 pid:13804 ppid: 6539 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4965 [inline] __schedule+0xa9a/0x4940 kernel/sched/core.c:6246 schedule+0xd2/0x260 kernel/sched/core.c:6319 schedule_timeout+0x14a/0x2a0 kernel/time/timer.c:1881 dev_deactivate_many+0x710/0xc60 net/sched/sch_generic.c:1302 dev_deactivate+0xe9/0x1b0 net/sched/sch_generic.c:1312 qdisc_graft+0xdac/0x1260 net/sched/sch_api.c:1061 tc_modify_qdisc+0xb92/0x1980 net/sched/sch_api.c:1671 rtnetlink_rcv_msg+0x413/0xb80 net/core/rtnetlink.c:5572 netlink_rcv_skb+0x153/0x420 net/netlink/af_netlink.c:2491 netlink_unicast_kernel net/netlink/af_netlink.c:1319 [inline] netlink_unicast+0x533/0x7d0 net/netlink/af_netlink.c:1345 netlink_sendmsg+0x86d/0xda0 net/netlink/af_netlink.c:1916 sock_sendmsg_nosec net/socket.c:704 [inline] sock_sendmsg+0xcf/0x120 net/socket.c:724 ____sys_sendmsg+0x331/0x810 net/socket.c:2409 ___sys_sendmsg+0xf3/0x170 net/socket.c:2463 __sys_sendmmsg+0x195/0x470 net/socket.c:2549 __do_sys_sendmmsg net/socket.c:2578 [inline] __se_sys_sendmmsg net/socket.c:2575 [inline] __x64_sys_sendmmsg+0x99/0x100 net/socket.c:2575 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:0x7fe74d798a39 RSP: 002b:00007fe74ad0e188 EFLAGS: 00000246 ORIG_RAX: 0000000000000133 RAX: ffffffffffffffda RBX: 00007fe74d89bf60 RCX: 00007fe74d798a39 RDX: 0492492492492805 RSI: 0000000020000140 RDI: 0000000000000003 RBP: 00007fe74d7f2c5f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffe8f32634f R14: 00007fe74ad0e300 R15: 0000000000022000 Showing all locks held in the system: 3 locks held by kworker/1:0/20: #0: ffff88814a6e3138 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff88814a6e3138 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline] #0: ffff88814a6e3138 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1198 [inline] #0: ffff88814a6e3138 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:634 [inline] #0: ffff88814a6e3138 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:661 [inline] #0: ffff88814a6e3138 ((wq_completion)ipv6_addrconf){+.+.}-{0:0}, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2268 #1: ffffc90000da7db0 ((addr_chk_work).work){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2272 #2: ffffffff8d2fcb68 (rtnl_mutex){+.+.}-{3:3}, at: addrconf_verify_work+0xa/0x20 net/ipv6/addrconf.c:4590 1 lock held by khungtaskd/27: #0: ffffffff8bb835a0 (rcu_read_lock){....}-{1:2}, at: debug_show_all_locks+0x53/0x260 kernel/locking/lockdep.c:6458 6 locks held by kworker/u4:4/983: 1 lock held by in:imklog/6229: #0: ffff888014ffeaf0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0xe9/0x100 fs/file.c:990 3 locks held by kworker/0:18/9451: #0: ffff888010c64d38 ((wq_completion)events){+.+.}-{0:0}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: ffff888010c64d38 ((wq_completion)events){+.+.}-{0:0}, at: arch_atomic_long_set include/linux/atomic/atomic-long.h:41 [inline] #0: ffff888010c64d38 ((wq_completion)events){+.+.}-{0:0}, at: atomic_long_set include/linux/atomic/atomic-instrumented.h:1198 [inline] #0: ffff888010c64d38 ((wq_completion)events){+.+.}-{0:0}, at: set_work_data kernel/workqueue.c:634 [inline] #0: ffff888010c64d38 ((wq_completion)events){+.+.}-{0:0}, at: set_work_pool_and_clear_pending kernel/workqueue.c:661 [inline] #0: ffff888010c64d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x896/0x1690 kernel/workqueue.c:2268 #1: ffffc9001864fdb0 (deferred_process_work){+.+.}-{0:0}, at: process_one_work+0x8ca/0x1690 kernel/workqueue.c:2272 #2: ffffffff8d2fcb68 (rtnl_mutex){+.+.}-{3:3}, at: switchdev_deferred_process_work+0xa/0x20 net/switchdev/switchdev.c:74 1 lock held by syz-executor.1/13805: #0: ffff8880719cd068 (&pipe->mutex/1){+.+.}-{3:3}, at: __pipe_lock fs/pipe.c:102 [inline] #0: ffff8880719cd068 (&pipe->mutex/1){+.+.}-{3:3}, at: pipe_write+0x633/0x1c00 fs/pipe.c:570 2 locks held by syz-executor.1/13810: #0: ffff8880719cd068 (&pipe->mutex/1){+.+.}-{3:3}, at: pipe_lock_nested fs/pipe.c:81 [inline] #0: ffff8880719cd068 (&pipe->mutex/1){+.+.}-{3:3}, at: pipe_lock+0x5a/0x70 fs/pipe.c:89 #1: ffffffff8d2fcb68 (rtnl_mutex){+.+.}-{3:3}, at: rtnl_lock net/core/rtnetlink.c:72 [inline] #1: ffffffff8d2fcb68 (rtnl_mutex){+.+.}-{3:3}, at: rtnetlink_rcv_msg+0x3be/0xb80 net/core/rtnetlink.c:5569 1 lock held by syz-executor.0/13804: #0: ffffffff8d2fcb68 (rtnl_mutex){+.+.}-{3:3}, at: rtnl_lock net/core/rtnetlink.c:72 [inline] #0: ffffffff8d2fcb68 (rtnl_mutex){+.+.}-{3:3}, at: rtnetlink_rcv_msg+0x3be/0xb80 net/core/rtnetlink.c:5569 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.15.0-rc6-next-20211020-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:106 nmi_cpu_backtrace.cold+0x47/0x144 lib/nmi_backtrace.c:105 nmi_trigger_cpumask_backtrace+0x1ae/0x220 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:254 [inline] watchdog+0xcb7/0xed0 kernel/hung_task.c:339 kthread+0x405/0x4f0 kernel/kthread.c:327 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 8544 Comm: kworker/u4:6 Not tainted 5.15.0-rc6-next-20211020-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: events_unbound toggle_allocation_gate RIP: 0010:strlen+0x54/0x90 lib/string.c:487 Code: 75 48 80 7d 00 00 74 39 48 bb 00 00 00 00 00 fc ff df 48 89 e8 48 83 c0 01 48 89 c2 48 89 c1 48 c1 ea 03 83 e1 07 0f b6 14 1a <38> ca 7f 04 84 d2 75 1f 80 38 00 75 de 48 83 c4 08 48 29 e8 5b 5d RSP: 0018:ffffc90016537820 EFLAGS: 00000246 RAX: ffffffff89a95628 RBX: dffffc0000000000 RCX: 0000000000000000 RDX: 0000000000000000 RSI: ffff888010daf138 RDI: ffffffff89a95620 RBP: ffffffff89a95620 R08: 0000000000000000 R09: ffffffff8d8febd7 R10: fffffbfff1b1fd7a R11: 000000000000003f R12: ffff888010daf138 R13: ffffffff8ba808a0 R14: ffff888010daf138 R15: ffffc900165378f0 FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007fa0e8c11028 CR3: 000000000b88e000 CR4: 00000000003506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: strlen include/linux/fortify-string.h:102 [inline] trace_event_get_offsets_lock include/trace/events/lock.h:39 [inline] perf_trace_lock+0xb1/0x4d0 include/trace/events/lock.h:39 trace_lock_release include/trace/events/lock.h:58 [inline] lock_release+0x4a8/0x720 kernel/locking/lockdep.c:5648 __raw_spin_unlock include/linux/spinlock_api_smp.h:150 [inline] _raw_spin_unlock+0x12/0x40 kernel/locking/spinlock.c:186 spin_unlock include/linux/spinlock.h:407 [inline] __text_poke+0x5d4/0x8c0 arch/x86/kernel/alternative.c:876 text_poke_bp_batch+0x2eb/0x560 arch/x86/kernel/alternative.c:1127 text_poke_flush arch/x86/kernel/alternative.c:1268 [inline] text_poke_flush arch/x86/kernel/alternative.c:1265 [inline] text_poke_finish+0x16/0x30 arch/x86/kernel/alternative.c:1275 arch_jump_label_transform_apply+0x13/0x20 arch/x86/kernel/jump_label.c:146 jump_label_update+0x1d5/0x430 kernel/jump_label.c:830 static_key_disable_cpuslocked+0x152/0x1b0 kernel/jump_label.c:207 static_key_disable+0x16/0x20 kernel/jump_label.c:215 toggle_allocation_gate mm/kfence/core.c:745 [inline] toggle_allocation_gate+0x183/0x390 mm/kfence/core.c:723 process_one_work+0x9b2/0x1690 kernel/workqueue.c:2297 worker_thread+0x658/0x11f0 kernel/workqueue.c:2444 kthread+0x405/0x4f0 kernel/kthread.c:327 ret_from_fork+0x1f/0x30 arch/x86/entry/entry_64.S:295 ---------------- Code disassembly (best guess): 0: 75 48 jne 0x4a 2: 80 7d 00 00 cmpb $0x0,0x0(%rbp) 6: 74 39 je 0x41 8: 48 bb 00 00 00 00 00 movabs $0xdffffc0000000000,%rbx f: fc ff df 12: 48 89 e8 mov %rbp,%rax 15: 48 83 c0 01 add $0x1,%rax 19: 48 89 c2 mov %rax,%rdx 1c: 48 89 c1 mov %rax,%rcx 1f: 48 c1 ea 03 shr $0x3,%rdx 23: 83 e1 07 and $0x7,%ecx 26: 0f b6 14 1a movzbl (%rdx,%rbx,1),%edx * 2a: 38 ca cmp %cl,%dl <-- trapping instruction 2c: 7f 04 jg 0x32 2e: 84 d2 test %dl,%dl 30: 75 1f jne 0x51 32: 80 38 00 cmpb $0x0,(%rax) 35: 75 de jne 0x15 37: 48 83 c4 08 add $0x8,%rsp 3b: 48 29 e8 sub %rbp,%rax 3e: 5b pop %rbx 3f: 5d pop %rbp