INFO: task kworker/u4:3:8764 blocked for more than 140 seconds. Not tainted 4.19.211-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:3 D26280 8764 2 0x80000000 audit: type=1804 audit(1674932035.531:719): pid=18410 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2030823040/syzkaller.DtLRqM/1403/bus" dev="sda1" ino=14178 res=1 Workqueue: writeback wb_workfn (flush-7:1) Call Trace: context_switch kernel/sched/core.c:2828 [inline] __schedule+0x887/0x2040 kernel/sched/core.c:3517 schedule+0x8d/0x1b0 kernel/sched/core.c:3561 schedule_preempt_disabled+0xf/0x20 kernel/sched/core.c:3619 __mutex_lock_common kernel/locking/mutex.c:1016 [inline] __mutex_lock+0x5f0/0x1190 kernel/locking/mutex.c:1078 f2fs_balance_fs+0x709/0xd80 fs/f2fs/segment.c:512 f2fs_write_inode+0x500/0x600 fs/f2fs/inode.c:630 write_inode fs/fs-writeback.c:1244 [inline] __writeback_single_inode+0x733/0x11d0 fs/fs-writeback.c:1442 writeback_sb_inodes+0x537/0xef0 fs/fs-writeback.c:1647 __writeback_inodes_wb+0xc6/0x280 fs/fs-writeback.c:1716 wb_writeback+0x841/0xcc0 fs/fs-writeback.c:1822 wb_check_old_data_flush fs/fs-writeback.c:1924 [inline] wb_do_writeback fs/fs-writeback.c:1977 [inline] wb_workfn+0x8ba/0x1250 fs/fs-writeback.c:2006 process_one_work+0x864/0x1570 kernel/workqueue.c:2153 worker_thread+0x64c/0x1130 kernel/workqueue.c:2296 kthread+0x33f/0x460 kernel/kthread.c:259 Bluetooth: hci7: command 0x0406 tx timeout ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 Showing all locks held in the system: 1 lock held by khungtaskd/1565: #0: 00000000d2b24518 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441 1 lock held by in:imklog/7824: #0: 0000000069ca21f4 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 2 locks held by agetty/7830: #0: 0000000028742071 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 #1: 000000003ce642a0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x217/0x1950 drivers/tty/n_tty.c:2154 2 locks held by agetty/7839: #0: 000000005e0a6bc9 (&tty->ldisc_sem){++++}, at: tty_ldisc_ref_wait+0x22/0x80 drivers/tty/tty_ldisc.c:272 audit: type=1804 audit(1674932036.862:720): pid=18470 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2030823040/syzkaller.DtLRqM/1404/bus" dev="sda1" ino=13888 res=1 #1: 00000000023610e3 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x217/0x1950 drivers/tty/n_tty.c:2154 4 locks held by kworker/u4:3/8764: #0: 000000001bf9b553 ((wq_completion)"writeback"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 audit: type=1804 audit(1674932036.862:721): pid=18470 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2030823040/syzkaller.DtLRqM/1404/bus" dev="sda1" ino=13888 res=1 #1: 000000007b009b7d ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 #2: 00000000bf0a31ae (&type->s_umount_key#72){++++}, at: trylock_super+0x1d/0x100 fs/super.c:412 audit: type=1804 audit(1674932036.862:722): pid=18470 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2030823040/syzkaller.DtLRqM/1404/bus" dev="sda1" ino=13888 res=1 #3: 0000000016a7566f (&sbi->gc_mutex){+.+.}, at: f2fs_balance_fs+0x709/0xd80 fs/f2fs/segment.c:512 3 locks held by kworker/u4:8/9556: 2 locks held by kworker/u4:11/30523: #0: 00000000f33bfb33 ((wq_completion)"events_unbound"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 audit: type=1804 audit(1674932036.862:723): pid=18470 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2030823040/syzkaller.DtLRqM/1404/bus" dev="sda1" ino=13888 res=1 #1: 00000000d2b24518 (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:428 [inline] #1: 00000000d2b24518 (rcu_read_lock){....}, at: update_curr+0x2c3/0x870 kernel/sched/fair.c:857 3 locks held by syz-executor.1/10294: 2 locks held by syz-executor.2/18504: 3 locks held by syz-executor.4/18519: ============================================= audit: type=1804 audit(1674932036.862:724): pid=18470 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.2" name="/root/syzkaller-testdir2030823040/syzkaller.DtLRqM/1404/bus" dev="sda1" ino=13888 res=1 NMI backtrace for cpu 1 CPU: 1 PID: 1565 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x1fc/0x2ef lib/dump_stack.c:118 nmi_cpu_backtrace.cold+0x63/0xa2 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1a6/0x1f0 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:203 [inline] watchdog+0x991/0xe60 kernel/hung_task.c:287 kthread+0x33f/0x460 kernel/kthread.c:259 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:415 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 4693 Comm: systemd-journal Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/12/2023 RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:789 [inline] RIP: 0010:__raw_spin_unlock_irqrestore include/linux/spinlock_api_smp.h:160 [inline] RIP: 0010:_raw_spin_unlock_irqrestore+0x52/0xe0 kernel/locking/spinlock.c:184 Code: 48 c7 c0 88 82 f1 89 48 ba 00 00 00 00 00 fc ff df 48 c1 e8 03 80 3c 10 00 75 72 48 83 3d cd 31 d8 01 00 74 64 48 89 df 57 9d <0f> 1f 44 00 00 e8 94 5c 4e f9 bf 01 00 00 00 e8 fa 1b 28 f9 65 8b RSP: 0018:ffff8880a0cdfb00 EFLAGS: 00000086 RAX: 1ffffffff13e3051 RBX: 0000000000000086 RCX: ffffffff814be140 RDX: dffffc0000000000 RSI: 0000000000000004 RDI: 0000000000000086 RBP: ffffffff8d44ad48 R08: 0000000000000000 R09: fffffbfff1a895a9 R10: ffffffff8d44ad4b R11: 0000000000000000 R12: 0000000000000286 R13: ffff88809a3708c0 R14: 0000000000000000 R15: dffffc0000000000 FS: 00007f39083868c0(0000) GS:ffff8880ba000000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f3905acd000 CR3: 00000000a178e000 CR4: 00000000003426f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: __debug_check_no_obj_freed lib/debugobjects.c:798 [inline] debug_check_no_obj_freed+0x201/0x490 lib/debugobjects.c:817 kmem_cache_free+0xff/0x260 mm/slab.c:3764 putname+0xe1/0x120 fs/namei.c:261 filename_parentat+0x4da/0x590 fs/namei.c:2399 filename_create+0x9e/0x490 fs/namei.c:3621 user_path_create fs/namei.c:3696 [inline] do_mkdirat+0xa0/0x2d0 fs/namei.c:3834 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f3907641687 Code: 00 b8 ff ff ff ff c3 0f 1f 40 00 48 8b 05 09 d8 2b 00 64 c7 00 5f 00 00 00 b8 ff ff ff ff c3 0f 1f 40 00 b8 53 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d e1 d7 2b 00 f7 d8 64 89 01 48 RSP: 002b:00007ffe15dbffb8 EFLAGS: 00000293 ORIG_RAX: 0000000000000053 RAX: ffffffffffffffda RBX: 00007ffe15dc2ed0 RCX: 00007f3907641687 RDX: 00007f39080b2a00 RSI: 00000000000001ed RDI: 0000558876d278a0 RBP: 00007ffe15dbfff0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000069 R11: 0000000000000293 R12: 0000000000000000 R13: 0000000000000000 R14: 00007ffe15dc2ed0 R15: 00007ffe15dc04e0