EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue INFO: task syz-executor.5:28889 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. syz-executor.5 D26880 28889 8149 0x00000004 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 EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue schedule_timeout+0x92d/0xfe0 kernel/time/timer.c:1794 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common+0x29c/0x470 kernel/sched/completion.c:115 usb_start_wait_urb+0x14b/0x4c0 drivers/usb/core/message.c:62 usb_bulk_msg+0x226/0x550 drivers/usb/core/message.c:253 proc_bulk+0x3de/0x860 drivers/usb/core/devio.c:1211 usbdev_do_ioctl+0x696/0x3030 drivers/usb/core/devio.c:2435 usbdev_ioctl+0x21/0x30 drivers/usb/core/devio.c:2585 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:501 [inline] do_vfs_ioctl+0xcdb/0x12e0 fs/ioctl.c:688 ksys_ioctl+0x9b/0xc0 fs/ioctl.c:705 __do_sys_ioctl fs/ioctl.c:712 [inline] __se_sys_ioctl fs/ioctl.c:710 [inline] __x64_sys_ioctl+0x6f/0xb0 fs/ioctl.c:710 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7fb5f9c530f9 Code: Bad RIP value. RSP: 002b:00007fb5f81c5168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 00007fb5f9d72f80 RCX: 00007fb5f9c530f9 RDX: 0000000020000100 RSI: 00000000c0185502 RDI: 0000000000000003 RBP: 00007fb5f9caeae9 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007fffc164297f R14: 00007fb5f81c5300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1569: #0: 000000002548cd01 (rcu_read_lock){....}, at: debug_show_all_locks+0x53/0x265 kernel/locking/lockdep.c:4441 1 lock held by in:imklog/7839: #0: 00000000de283c70 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x26f/0x310 fs/file.c:767 2 locks held by syz-executor.2/8161: #0: 00000000a2a4a586 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1826 [inline] #0: 00000000a2a4a586 (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 kernel/sched/core.c:3455 #1: 000000002548cd01 (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:428 [inline] #1: 000000002548cd01 (rcu_read_lock){....}, at: update_curr+0x2c3/0x870 kernel/sched/fair.c:857 2 locks held by kworker/u4:6/8869: 2 locks held by kworker/0:0/16450: #0: 0000000047fd2ebf ((wq_completion)"rcu_gp"){+.+.}, at: process_one_work+0x767/0x1570 kernel/workqueue.c:2124 EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue #1: 00000000850a91a1 ((work_completion)(&rew.rew_work)){+.+.}, at: process_one_work+0x79c/0x1570 kernel/workqueue.c:2128 2 locks held by syz-executor.1/2936: #0: 000000008caf0114 (&sb->s_type->i_mutex_key#13){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #0: 000000008caf0114 (&sb->s_type->i_mutex_key#13){+.+.}, at: __sock_release+0x86/0x2a0 net/socket.c:598 #1: 00000000f1b04379 (rcu_preempt_state.exp_mutex){+.+.}, at: exp_funnel_lock kernel/rcu/tree_exp.h:297 [inline] #1: 00000000f1b04379 (rcu_preempt_state.exp_mutex){+.+.}, at: _synchronize_rcu_expedited+0x4dc/0x6f0 kernel/rcu/tree_exp.h:667 2 locks held by syz-executor.5/2977: #0: 00000000cddfc2ca (&sb->s_type->i_mutex_key#13){+.+.}, at: inode_lock include/linux/fs.h:748 [inline] #0: 00000000cddfc2ca (&sb->s_type->i_mutex_key#13){+.+.}, at: __sock_release+0x86/0x2a0 net/socket.c:598 #1: 00000000f1b04379 (rcu_preempt_state.exp_mutex){+.+.}, at: exp_funnel_lock kernel/rcu/tree_exp.h:329 [inline] #1: 00000000f1b04379 (rcu_preempt_state.exp_mutex){+.+.}, at: _synchronize_rcu_expedited+0x256/0x6f0 kernel/rcu/tree_exp.h:667 1 lock held by syz-executor.2/2995: #0: 00000000a2a4a586 (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1826 [inline] #0: 00000000a2a4a586 (&rq->lock){-.-.}, at: __schedule+0x1f9/0x2040 kernel/sched/core.c:3455 1 lock held by syz-executor.2/3005: #0: 000000009283ea29 (&pipe->mutex/1){+.+.}, at: pipe_lock_nested fs/pipe.c:77 [inline] #0: 000000009283ea29 (&pipe->mutex/1){+.+.}, at: pipe_lock fs/pipe.c:85 [inline] #0: 000000009283ea29 (&pipe->mutex/1){+.+.}, at: pipe_wait+0x1bd/0x1e0 fs/pipe.c:133 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 1569 Comm: khungtaskd Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/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 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 4691 Comm: systemd-journal Not tainted 4.19.211-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/21/2023 RIP: 0010:__debug_check_no_obj_freed lib/debugobjects.c:777 [inline] RIP: 0010:debug_check_no_obj_freed+0x1ce/0x490 lib/debugobjects.c:817 Code: 00 00 00 ad de 4d 89 60 08 4c 89 c7 49 89 00 e8 a8 d6 ff ff 09 c3 4d 85 f6 74 2c 4d 89 f0 4c 89 c0 48 c1 e8 03 42 80 3c 38 00 <0f> 84 23 ff ff ff 4c 89 c7 4c 89 44 24 38 e8 9f 16 21 fe 4c 8b 44 RSP: 0018:ffff8880a0e2fbe8 EFLAGS: 00000046 RAX: 1ffff110154b1b18 RBX: 0000000000000000 RCX: ffffffff814bdebb RDX: 1ffffffff1a8276b RSI: 0000000000000004 RDI: ffff8880aa58df68 RBP: 0000000000000001 R08: ffff8880aa58d8c0 R09: ffffe8ffffd8bf00 R10: ffffffff8d413b4b R11: 0000000000000000 R12: dead000000000200 R13: ffff8880a6520c00 R14: ffff8880aa58d8c0 R15: dffffc0000000000 FS: 00007f8736b008c0(0000) GS:ffff8880ba100000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f87342cc000 CR3: 00000000a12e2000 CR4: 00000000003406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: kmem_cache_free+0xff/0x260 mm/slab.c:3764 putname+0xe1/0x120 fs/namei.c:261 filename_lookup+0x3d0/0x5a0 fs/namei.c:2358 user_path_at include/linux/namei.h:57 [inline] do_faccessat+0x248/0x7a0 fs/open.c:397 do_syscall_64+0xf9/0x620 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x7f8735dbb9c7 Code: 83 c4 08 48 3d 01 f0 ff ff 73 01 c3 48 8b 0d c8 d4 2b 00 f7 d8 64 89 01 48 83 c8 ff c3 66 0f 1f 44 00 00 b8 15 00 00 00 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 8b 0d a1 d4 2b 00 f7 d8 64 89 01 48 RSP: 002b:00007ffcfd021e28 EFLAGS: 00000246 ORIG_RAX: 0000000000000015 RAX: ffffffffffffffda RBX: 00007ffcfd024d40 RCX: 00007f8735dbb9c7 RDX: 00007f873682ca00 RSI: 0000000000000000 RDI: 000055790a0bb9a3 RBP: 00007ffcfd021e60 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000000 R14: 00007ffcfd024d40 R15: 00007ffcfd022350 kauditd_printk_skb: 122 callbacks suppressed audit: type=1804 audit(1675982796.390:2223): pid=3037 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=open_writers comm="syz-executor.3" name="/root/syzkaller-testdir2012227425/syzkaller.n2hTY5/1931/bus" dev="sda1" ino=14897 res=1 audit: type=1804 audit(1675982796.560:2224): pid=3022 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.3" name="/root/syzkaller-testdir2012227425/syzkaller.n2hTY5/1931/bus" dev="sda1" ino=14897 res=1 EXT4-fs (loop3): mounted filesystem without journal. Opts: ,errors=continue