INFO: task syz-executor.1:16129 blocked for more than 143 seconds. Not tainted 5.15.0-rc2-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.1 state:D stack:28688 pid:16129 ppid: 6559 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4940 [inline] __schedule+0xc8d/0x1270 kernel/sched/core.c:6287 schedule+0x14b/0x210 kernel/sched/core.c:6366 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6425 __mutex_lock_common+0xdff/0x2550 kernel/locking/mutex.c:669 __mutex_lock kernel/locking/mutex.c:729 [inline] mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:743 __fdget_pos+0x24e/0x2f0 fs/file.c:990 fdget_pos include/linux/file.h:75 [inline] __do_sys_getdents64 fs/readdir.c:365 [inline] __se_sys_getdents64+0x1bb/0x4e0 fs/readdir.c:354 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:0x7f57a8ab6739 RSP: 002b:00007f57a5feb188 EFLAGS: 00000246 ORIG_RAX: 00000000000000d9 RAX: ffffffffffffffda RBX: 00007f57a8bbb0f0 RCX: 00007f57a8ab6739 RDX: 0000000000000034 RSI: 0000000000000000 RDI: 0000000000000006 RBP: 00007f57a8b10cc4 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f57a8bbb0f0 R13: 00007ffe24658c9f R14: 00007f57a5feb300 R15: 0000000000022000 INFO: task syz-executor.0:16137 blocked for more than 144 seconds. Not tainted 5.15.0-rc2-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.0 state:D stack:28688 pid:16137 ppid: 6557 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4940 [inline] __schedule+0xc8d/0x1270 kernel/sched/core.c:6287 schedule+0x14b/0x210 kernel/sched/core.c:6366 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6425 __mutex_lock_common+0xdff/0x2550 kernel/locking/mutex.c:669 __mutex_lock kernel/locking/mutex.c:729 [inline] mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:743 __fdget_pos+0x24e/0x2f0 fs/file.c:990 fdget_pos include/linux/file.h:75 [inline] __do_sys_getdents64 fs/readdir.c:365 [inline] __se_sys_getdents64+0x1bb/0x4e0 fs/readdir.c:354 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:0x7f0be9cb8739 RSP: 002b:00007f0be71ed188 EFLAGS: 00000246 ORIG_RAX: 00000000000000d9 RAX: ffffffffffffffda RBX: 00007f0be9dbd0f0 RCX: 00007f0be9cb8739 RDX: 0000000000000034 RSI: 0000000000000000 RDI: 0000000000000006 RBP: 00007f0be9d12cc4 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f0be9dbd0f0 R13: 00007ffe662b08df R14: 00007f0be71ed300 R15: 0000000000022000 INFO: task syz-executor.3:16141 blocked for more than 144 seconds. Not tainted 5.15.0-rc2-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.3 state:D stack:27792 pid:16141 ppid: 6565 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4940 [inline] __schedule+0xc8d/0x1270 kernel/sched/core.c:6287 schedule+0x14b/0x210 kernel/sched/core.c:6366 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6425 __mutex_lock_common+0xdff/0x2550 kernel/locking/mutex.c:669 __mutex_lock kernel/locking/mutex.c:729 [inline] mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:743 __fdget_pos+0x24e/0x2f0 fs/file.c:990 fdget_pos include/linux/file.h:75 [inline] __do_sys_getdents64 fs/readdir.c:365 [inline] __se_sys_getdents64+0x1bb/0x4e0 fs/readdir.c:354 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:0x7f838bb78739 RSP: 002b:00007f83890ce188 EFLAGS: 00000246 ORIG_RAX: 00000000000000d9 RAX: ffffffffffffffda RBX: 00007f838bc7d038 RCX: 00007f838bb78739 RDX: 0000000000000034 RSI: 0000000000000000 RDI: 0000000000000006 RBP: 00007f838bbd2cc4 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f838bc7d038 R13: 00007ffc79b7acef R14: 00007f83890ce300 R15: 0000000000022000 INFO: task syz-executor.2:16149 blocked for more than 145 seconds. Not tainted 5.15.0-rc2-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.2 state:D stack:27792 pid:16149 ppid: 6561 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4940 [inline] __schedule+0xc8d/0x1270 kernel/sched/core.c:6287 schedule+0x14b/0x210 kernel/sched/core.c:6366 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6425 __mutex_lock_common+0xdff/0x2550 kernel/locking/mutex.c:669 __mutex_lock kernel/locking/mutex.c:729 [inline] mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:743 __fdget_pos+0x24e/0x2f0 fs/file.c:990 fdget_pos include/linux/file.h:75 [inline] __do_sys_getdents64 fs/readdir.c:365 [inline] __se_sys_getdents64+0x1bb/0x4e0 fs/readdir.c:354 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:0x7f3702833739 RSP: 002b:00007f36ffd89188 EFLAGS: 00000246 ORIG_RAX: 00000000000000d9 RAX: ffffffffffffffda RBX: 00007f3702938038 RCX: 00007f3702833739 RDX: 0000000000000034 RSI: 0000000000000000 RDI: 0000000000000006 RBP: 00007f370288dcc4 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f3702938038 R13: 00007fff0092855f R14: 00007f36ffd89300 R15: 0000000000022000 INFO: task syz-executor.5:16158 blocked for more than 145 seconds. Not tainted 5.15.0-rc2-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. task:syz-executor.5 state:D stack:27792 pid:16158 ppid: 7063 flags:0x00004004 Call Trace: context_switch kernel/sched/core.c:4940 [inline] __schedule+0xc8d/0x1270 kernel/sched/core.c:6287 schedule+0x14b/0x210 kernel/sched/core.c:6366 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:6425 __mutex_lock_common+0xdff/0x2550 kernel/locking/mutex.c:669 __mutex_lock kernel/locking/mutex.c:729 [inline] mutex_lock_nested+0x1a/0x20 kernel/locking/mutex.c:743 __fdget_pos+0x24e/0x2f0 fs/file.c:990 fdget_pos include/linux/file.h:75 [inline] __do_sys_getdents64 fs/readdir.c:365 [inline] __se_sys_getdents64+0x1bb/0x4e0 fs/readdir.c:354 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:0x7f4791d45739 RSP: 002b:00007f478f29b188 EFLAGS: 00000246 ORIG_RAX: 00000000000000d9 RAX: ffffffffffffffda RBX: 00007f4791e4a038 RCX: 00007f4791d45739 RDX: 0000000000000034 RSI: 0000000000000000 RDI: 0000000000000006 RBP: 00007f4791d9fcc4 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 00007f4791e4a038 R13: 00007ffd5a5f8c0f R14: 00007f478f29b300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by ksoftirqd/1/19: 1 lock held by khungtaskd/27: #0: ffffffff8c91c200 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x0/0x30 3 locks held by kworker/u4:3/159: 1 lock held by in:imklog/6231: #0: ffff88807e8900f0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x2f0 fs/file.c:990 2 locks held by agetty/6465: #0: ffff88801b6b3098 (&tty->ldisc_sem){++++}-{0:0}, at: tty_ldisc_ref_wait+0x21/0x70 drivers/tty/tty_ldisc.c:252 #1: ffffc900012682e8 (&ldata->atomic_read_lock){+.+.}-{3:3}, at: n_tty_read+0x6c5/0x1c60 drivers/tty/n_tty.c:2113 2 locks held by syz-executor.1/16115: #0: ffff8880269c3770 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x2f0 fs/file.c:990 #1: ffff88804ba78298 (&sb->s_type->i_mutex_key#25){++++}-{3:3}, at: iterate_dir+0x124/0x640 fs/readdir.c:55 1 lock held by syz-executor.1/16129: #0: ffff8880269c3770 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x2f0 fs/file.c:990 2 locks held by syz-executor.0/16127: 1 lock held by syz-executor.0/16137: #0: ffff888079784d70 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x2f0 fs/file.c:990 2 locks held by syz-executor.3/16132: 1 lock held by syz-executor.3/16141: #0: ffff88801d4079f0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x2f0 fs/file.c:990 2 locks held by syz-executor.2/16143: 1 lock held by syz-executor.2/16149: #0: ffff88801bc179f0 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x2f0 fs/file.c:990 2 locks held by syz-executor.5/16153: 1 lock held by syz-executor.5/16158: #0: ffff88802b486370 (&f->f_pos_lock){+.+.}-{3:3}, at: __fdget_pos+0x24e/0x2f0 fs/file.c:990 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.15.0-rc2-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+0xc54/0xca0 kernel/hung_task.c:295 kthread+0x453/0x480 kernel/kthread.c:319 ret_from_fork+0x1f/0x30 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 15528 Comm: kworker/0:16 Not tainted 5.15.0-rc2-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: events free_obj_work RIP: 0010:get_lock_parent_ip include/linux/ftrace.h:857 [inline] RIP: 0010:preempt_latency_start kernel/sched/core.c:5381 [inline] RIP: 0010:preempt_count_add+0x66/0x130 kernel/sched/core.c:5406 Code: 9f a8 7e 0f b6 c0 3d f5 00 00 00 73 5a 65 8b 05 e8 9f a8 7e 25 ff ff ff 7f 39 d8 75 44 4c 8b 74 24 18 4c 89 f7 e8 9a 5b 0c 00 <85> c0 74 0a 45 31 f6 31 ff e8 8c 5b 0c 00 65 48 8b 1c 25 c0 ef 01 RSP: 0018:ffffc9000453f5a0 EFLAGS: 00000246 RAX: 0000000000000000 RBX: 0000000000000001 RCX: ffffffff89fb4900 RDX: ffffc9000453fae8 RSI: ffffffff81ccec65 RDI: ffffffff8139f319 RBP: 1ffff920008a7ed0 R08: 0000000000000004 R09: ffffc9000453f770 R10: fffff520008a7edc R11: 0000000000000000 R12: ffffc9000453f6b8 R13: ffffc9000453f680 R14: ffffffff8139f319 R15: dffffc0000000000 FS: 0000000000000000(0000) GS:ffff8880b9c00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f02f1f26000 CR3: 000000002c8e3000 CR4: 00000000001506f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: unwind_next_frame+0xa9/0x1fa0 arch/x86/kernel/unwind_orc.c:428 arch_stack_walk+0x112/0x140 arch/x86/kernel/stacktrace.c:25 stack_trace_save+0x11b/0x1e0 kernel/stacktrace.c:121 kasan_save_stack mm/kasan/common.c:38 [inline] kasan_set_track+0x4c/0x80 mm/kasan/common.c:46 kasan_set_free_info+0x1f/0x40 mm/kasan/generic.c:360 ____kasan_slab_free+0x10d/0x150 mm/kasan/common.c:366 kasan_slab_free include/linux/kasan.h:230 [inline] slab_free_hook mm/slub.c:1700 [inline] slab_free_freelist_hook+0x129/0x1a0 mm/slub.c:1725 slab_free mm/slub.c:3483 [inline] kmem_cache_free+0x85/0x180 mm/slub.c:3499 free_obj_work+0x4d8/0x680 lib/debugobjects.c:338 process_one_work+0x853/0x1140 kernel/workqueue.c:2297 worker_thread+0xac1/0x1320 kernel/workqueue.c:2444 kthread+0x453/0x480 kernel/kthread.c:319 ret_from_fork+0x1f/0x30 ---------------- Code disassembly (best guess): 0: 9f lahf 1: a8 7e test $0x7e,%al 3: 0f b6 c0 movzbl %al,%eax 6: 3d f5 00 00 00 cmp $0xf5,%eax b: 73 5a jae 0x67 d: 65 8b 05 e8 9f a8 7e mov %gs:0x7ea89fe8(%rip),%eax # 0x7ea89ffc 14: 25 ff ff ff 7f and $0x7fffffff,%eax 19: 39 d8 cmp %ebx,%eax 1b: 75 44 jne 0x61 1d: 4c 8b 74 24 18 mov 0x18(%rsp),%r14 22: 4c 89 f7 mov %r14,%rdi 25: e8 9a 5b 0c 00 callq 0xc5bc4 * 2a: 85 c0 test %eax,%eax <-- trapping instruction 2c: 74 0a je 0x38 2e: 45 31 f6 xor %r14d,%r14d 31: 31 ff xor %edi,%edi 33: e8 8c 5b 0c 00 callq 0xc5bc4 38: 65 gs 39: 48 rex.W 3a: 8b .byte 0x8b 3b: 1c 25 sbb $0x25,%al 3d: c0 ef 01 shr $0x1,%bh