Bluetooth: hci4 command 0x0406 tx timeout Bluetooth: hci5 command 0x0406 tx timeout Bluetooth: hci0 command 0x0406 tx timeout random: crng init done random: 7 urandom warning(s) missed due to ratelimiting INFO: task syz-executor.1:7174 blocked for more than 140 seconds. Not tainted 4.14.227-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D26256 7174 5776 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x824/0x1ee0 kernel/sched/core.c:3384 schedule+0x7f/0x1b0 kernel/sched/core.c:3428 io_schedule+0x1c/0x70 kernel/sched/core.c:5032 bit_wait_io+0xf/0x90 kernel/sched/wait_bit.c:249 __wait_on_bit_lock+0xcb/0x1c0 kernel/sched/wait_bit.c:89 out_of_line_wait_on_bit_lock+0xbd/0xe0 kernel/sched/wait_bit.c:116 wait_on_bit_lock_io include/linux/wait_bit.h:213 [inline] __lock_buffer+0x3c/0x40 fs/buffer.c:72 lock_buffer include/linux/buffer_head.h:374 [inline] __sync_dirty_buffer+0x16f/0x1d0 fs/buffer.c:3235 sync_dirty_buffer+0xe/0x10 fs/buffer.c:3261 __ext4_handle_dirty_metadata+0x134/0x4c0 fs/ext4/ext4_jbd2.c:300 ext4_convert_inline_data_nolock+0x4b7/0xb70 fs/ext4/inline.c:1246 ext4_convert_inline_data+0x296/0x3b0 fs/ext4/inline.c:2001 ext4_fallocate+0xdd/0x19f0 fs/ext4/extents.c:4964 vfs_fallocate+0x2ba/0x770 fs/open.c:319 SYSC_fallocate fs/open.c:342 [inline] SyS_fallocate+0x3f/0x60 fs/open.c:336 do_syscall_64+0x1c7/0x5b0 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465689 RSP: 002b:00007ffa57ed5188 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 000000000055bf00 RCX: 0000000000465689 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00000000004af652 R08: 0000000000000000 R09: 0000000000000000 R10: 000000000000ffe0 R11: 0000000000000246 R12: 000000000055bf00 R13: 00007fff6f47b9ef R14: 00007ffa57ed5300 R15: 0000000000022000 INFO: task syz-executor.3:7278 blocked for more than 140 seconds. Not tainted 4.14.227-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D26440 7278 5777 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x824/0x1ee0 kernel/sched/core.c:3384 schedule+0x7f/0x1b0 kernel/sched/core.c:3428 io_schedule+0x1c/0x70 kernel/sched/core.c:5032 bit_wait_io+0xf/0x90 kernel/sched/wait_bit.c:249 __wait_on_bit_lock+0xcb/0x1c0 kernel/sched/wait_bit.c:89 out_of_line_wait_on_bit_lock+0xbd/0xe0 kernel/sched/wait_bit.c:116 wait_on_bit_lock_io include/linux/wait_bit.h:213 [inline] __lock_buffer+0x3c/0x40 fs/buffer.c:72 lock_buffer include/linux/buffer_head.h:374 [inline] __sync_dirty_buffer+0x16f/0x1d0 fs/buffer.c:3235 sync_dirty_buffer+0xe/0x10 fs/buffer.c:3261 __ext4_handle_dirty_metadata+0x134/0x4c0 fs/ext4/ext4_jbd2.c:300 ext4_convert_inline_data_nolock+0x4b7/0xb70 fs/ext4/inline.c:1246 ext4_convert_inline_data+0x296/0x3b0 fs/ext4/inline.c:2001 ext4_fallocate+0xdd/0x19f0 fs/ext4/extents.c:4964 vfs_fallocate+0x2ba/0x770 fs/open.c:319 SYSC_fallocate fs/open.c:342 [inline] SyS_fallocate+0x3f/0x60 fs/open.c:336 do_syscall_64+0x1c7/0x5b0 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465689 RSP: 002b:00007f9da08e3188 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 000000000055bf00 RCX: 0000000000465689 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00000000004af652 R08: 0000000000000000 R09: 0000000000000000 R10: 000000000000ffe0 R11: 0000000000000246 R12: 000000000055bf00 R13: 00007ffc7e2941df R14: 00007f9da08e3300 R15: 0000000000022000 INFO: task syz-executor.0:7344 blocked for more than 140 seconds. Not tainted 4.14.227-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D26440 7344 5773 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x824/0x1ee0 kernel/sched/core.c:3384 schedule+0x7f/0x1b0 kernel/sched/core.c:3428 io_schedule+0x1c/0x70 kernel/sched/core.c:5032 bit_wait_io+0xf/0x90 kernel/sched/wait_bit.c:249 __wait_on_bit_lock+0xcb/0x1c0 kernel/sched/wait_bit.c:89 out_of_line_wait_on_bit_lock+0xbd/0xe0 kernel/sched/wait_bit.c:116 wait_on_bit_lock_io include/linux/wait_bit.h:213 [inline] __lock_buffer+0x3c/0x40 fs/buffer.c:72 lock_buffer include/linux/buffer_head.h:374 [inline] __sync_dirty_buffer+0x16f/0x1d0 fs/buffer.c:3235 sync_dirty_buffer+0xe/0x10 fs/buffer.c:3261 __ext4_handle_dirty_metadata+0x134/0x4c0 fs/ext4/ext4_jbd2.c:300 ext4_convert_inline_data_nolock+0x4b7/0xb70 fs/ext4/inline.c:1246 ext4_convert_inline_data+0x296/0x3b0 fs/ext4/inline.c:2001 ext4_fallocate+0xdd/0x19f0 fs/ext4/extents.c:4964 vfs_fallocate+0x2ba/0x770 fs/open.c:319 SYSC_fallocate fs/open.c:342 [inline] SyS_fallocate+0x3f/0x60 fs/open.c:336 do_syscall_64+0x1c7/0x5b0 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465689 RSP: 002b:00007feeafb37188 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 000000000055bf00 RCX: 0000000000465689 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00000000004af652 R08: 0000000000000000 R09: 0000000000000000 R10: 000000000000ffe0 R11: 0000000000000246 R12: 000000000055bf00 R13: 00007ffc5ddac68f R14: 00007feeafb37300 R15: 0000000000022000 INFO: task syz-executor.2:7367 blocked for more than 140 seconds. Not tainted 4.14.227-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D26440 7367 5770 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x824/0x1ee0 kernel/sched/core.c:3384 schedule+0x7f/0x1b0 kernel/sched/core.c:3428 io_schedule+0x1c/0x70 kernel/sched/core.c:5032 bit_wait_io+0xf/0x90 kernel/sched/wait_bit.c:249 __wait_on_bit_lock+0xcb/0x1c0 kernel/sched/wait_bit.c:89 out_of_line_wait_on_bit_lock+0xbd/0xe0 kernel/sched/wait_bit.c:116 wait_on_bit_lock_io include/linux/wait_bit.h:213 [inline] __lock_buffer+0x3c/0x40 fs/buffer.c:72 lock_buffer include/linux/buffer_head.h:374 [inline] __sync_dirty_buffer+0x16f/0x1d0 fs/buffer.c:3235 sync_dirty_buffer+0xe/0x10 fs/buffer.c:3261 __ext4_handle_dirty_metadata+0x134/0x4c0 fs/ext4/ext4_jbd2.c:300 ext4_convert_inline_data_nolock+0x4b7/0xb70 fs/ext4/inline.c:1246 ext4_convert_inline_data+0x296/0x3b0 fs/ext4/inline.c:2001 ext4_fallocate+0xdd/0x19f0 fs/ext4/extents.c:4964 vfs_fallocate+0x2ba/0x770 fs/open.c:319 SYSC_fallocate fs/open.c:342 [inline] SyS_fallocate+0x3f/0x60 fs/open.c:336 do_syscall_64+0x1c7/0x5b0 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465689 RSP: 002b:00007fcbcef6b188 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 000000000055bf00 RCX: 0000000000465689 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00000000004af652 R08: 0000000000000000 R09: 0000000000000000 R10: 000000000000ffe0 R11: 0000000000000246 R12: 000000000055bf00 R13: 00007ffc7fd7a29f R14: 00007fcbcef6b300 R15: 0000000000022000 INFO: task syz-executor.5:7385 blocked for more than 140 seconds. Not tainted 4.14.227-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D26440 7385 5772 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x824/0x1ee0 kernel/sched/core.c:3384 schedule+0x7f/0x1b0 kernel/sched/core.c:3428 io_schedule+0x1c/0x70 kernel/sched/core.c:5032 bit_wait_io+0xf/0x90 kernel/sched/wait_bit.c:249 __wait_on_bit_lock+0xcb/0x1c0 kernel/sched/wait_bit.c:89 out_of_line_wait_on_bit_lock+0xbd/0xe0 kernel/sched/wait_bit.c:116 wait_on_bit_lock_io include/linux/wait_bit.h:213 [inline] __lock_buffer+0x3c/0x40 fs/buffer.c:72 lock_buffer include/linux/buffer_head.h:374 [inline] __sync_dirty_buffer+0x16f/0x1d0 fs/buffer.c:3235 sync_dirty_buffer+0xe/0x10 fs/buffer.c:3261 __ext4_handle_dirty_metadata+0x134/0x4c0 fs/ext4/ext4_jbd2.c:300 ext4_convert_inline_data_nolock+0x4b7/0xb70 fs/ext4/inline.c:1246 ext4_convert_inline_data+0x296/0x3b0 fs/ext4/inline.c:2001 ext4_fallocate+0xdd/0x19f0 fs/ext4/extents.c:4964 vfs_fallocate+0x2ba/0x770 fs/open.c:319 SYSC_fallocate fs/open.c:342 [inline] SyS_fallocate+0x3f/0x60 fs/open.c:336 do_syscall_64+0x1c7/0x5b0 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465689 RSP: 002b:00007f1c570f5188 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 000000000055bf00 RCX: 0000000000465689 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00000000004af652 R08: 0000000000000000 R09: 0000000000000000 R10: 000000000000ffe0 R11: 0000000000000246 R12: 000000000055bf00 R13: 00007ffc1127d1bf R14: 00007f1c570f5300 R15: 0000000000022000 INFO: task syz-executor.4:7397 blocked for more than 140 seconds. Not tainted 4.14.227-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D26440 7397 5778 0x00000004 Call Trace: context_switch kernel/sched/core.c:2808 [inline] __schedule+0x824/0x1ee0 kernel/sched/core.c:3384 schedule+0x7f/0x1b0 kernel/sched/core.c:3428 io_schedule+0x1c/0x70 kernel/sched/core.c:5032 bit_wait_io+0xf/0x90 kernel/sched/wait_bit.c:249 __wait_on_bit_lock+0xcb/0x1c0 kernel/sched/wait_bit.c:89 out_of_line_wait_on_bit_lock+0xbd/0xe0 kernel/sched/wait_bit.c:116 wait_on_bit_lock_io include/linux/wait_bit.h:213 [inline] __lock_buffer+0x3c/0x40 fs/buffer.c:72 lock_buffer include/linux/buffer_head.h:374 [inline] __sync_dirty_buffer+0x16f/0x1d0 fs/buffer.c:3235 sync_dirty_buffer+0xe/0x10 fs/buffer.c:3261 __ext4_handle_dirty_metadata+0x134/0x4c0 fs/ext4/ext4_jbd2.c:300 ext4_convert_inline_data_nolock+0x4b7/0xb70 fs/ext4/inline.c:1246 ext4_convert_inline_data+0x296/0x3b0 fs/ext4/inline.c:2001 ext4_fallocate+0xdd/0x19f0 fs/ext4/extents.c:4964 vfs_fallocate+0x2ba/0x770 fs/open.c:319 SYSC_fallocate fs/open.c:342 [inline] SyS_fallocate+0x3f/0x60 fs/open.c:336 do_syscall_64+0x1c7/0x5b0 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465689 RSP: 002b:00007f9e8cc98188 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 000000000055bf00 RCX: 0000000000465689 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000003 RBP: 00000000004af652 R08: 0000000000000000 R09: 0000000000000000 R10: 000000000000ffe0 R11: 0000000000000246 R12: 000000000055bf00 R13: 00007ffccba76f0f R14: 00007f9e8cc98300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1068: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x79/0x218 kernel/locking/lockdep.c:4548 2 locks held by syz-executor.1/7174: #0: (sb_writers#3){.+.+}, at: [] file_start_write include/linux/fs.h:2712 [inline] #0: (sb_writers#3){.+.+}, at: [] vfs_fallocate+0x42c/0x770 fs/open.c:318 #1: (&ei->xattr_sem){++++}, at: [] ext4_write_lock_xattr fs/ext4/xattr.h:141 [inline] #1: (&ei->xattr_sem){++++}, at: [] ext4_convert_inline_data+0x1d3/0x3b0 fs/ext4/inline.c:1999 2 locks held by syz-executor.3/7278: #0: (sb_writers#3){.+.+}, at: [] file_start_write include/linux/fs.h:2712 [inline] #0: (sb_writers#3){.+.+}, at: [] vfs_fallocate+0x42c/0x770 fs/open.c:318 #1: (&ei->xattr_sem){++++}, at: [] ext4_write_lock_xattr fs/ext4/xattr.h:141 [inline] #1: (&ei->xattr_sem){++++}, at: [] ext4_convert_inline_data+0x1d3/0x3b0 fs/ext4/inline.c:1999 2 locks held by syz-executor.0/7344: #0: (sb_writers#3){.+.+}, at: [] file_start_write include/linux/fs.h:2712 [inline] #0: (sb_writers#3){.+.+}, at: [] vfs_fallocate+0x42c/0x770 fs/open.c:318 #1: (&ei->xattr_sem){++++}, at: [] ext4_write_lock_xattr fs/ext4/xattr.h:141 [inline] #1: (&ei->xattr_sem){++++}, at: [] ext4_convert_inline_data+0x1d3/0x3b0 fs/ext4/inline.c:1999 2 locks held by syz-executor.2/7367: #0: (sb_writers#3){.+.+}, at: [] file_start_write include/linux/fs.h:2712 [inline] #0: (sb_writers#3){.+.+}, at: [] vfs_fallocate+0x42c/0x770 fs/open.c:318 #1: (&ei->xattr_sem){++++}, at: [] ext4_write_lock_xattr fs/ext4/xattr.h:141 [inline] #1: (&ei->xattr_sem){++++}, at: [] ext4_convert_inline_data+0x1d3/0x3b0 fs/ext4/inline.c:1999 2 locks held by syz-executor.5/7385: #0: (sb_writers#3){.+.+}, at: [] file_start_write include/linux/fs.h:2712 [inline] #0: (sb_writers#3){.+.+}, at: [] vfs_fallocate+0x42c/0x770 fs/open.c:318 #1: (&ei->xattr_sem){++++}, at: [] ext4_write_lock_xattr fs/ext4/xattr.h:141 [inline] #1: (&ei->xattr_sem){++++}, at: [] ext4_convert_inline_data+0x1d3/0x3b0 fs/ext4/inline.c:1999 2 locks held by syz-executor.4/7397: #0: (sb_writers#3){.+.+}, at: [] file_start_write include/linux/fs.h:2712 [inline] #0: (sb_writers#3){.+.+}, at: [] vfs_fallocate+0x42c/0x770 fs/open.c:318 #1: (&ei->xattr_sem){++++}, at: [] ext4_write_lock_xattr fs/ext4/xattr.h:141 [inline] #1: (&ei->xattr_sem){++++}, at: [] ext4_convert_inline_data+0x1d3/0x3b0 fs/ext4/inline.c:1999 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1068 Comm: khungtaskd Not tainted 4.14.227-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x14b/0x1e7 lib/dump_stack.c:58 nmi_cpu_backtrace.cold.0+0x3c/0x78 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0xf5/0x120 lib/nmi_backtrace.c:62 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline] watchdog+0x51b/0xa70 kernel/hung_task.c:274 kthread+0x338/0x400 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 skipped: idling at pc 0xffffffff866c7052