Bluetooth: hci3 command 0x0406 tx timeout Bluetooth: hci5 command 0x0406 tx timeout Bluetooth: hci4 command 0x0406 tx timeout random: crng init done random: 7 urandom warning(s) missed due to ratelimiting INFO: task syz-executor.1:7134 blocked for more than 140 seconds. Not tainted 4.14.231-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D26272 7134 5764 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:00007f75cef30188 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: 00007ffdf3ba87cf R14: 00007f75cef30300 R15: 0000000000022000 INFO: task syz-executor.0:7269 blocked for more than 140 seconds. Not tainted 4.14.231-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D26440 7269 5762 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:00007f3c1be60188 EFLAGS: 00000246 ORIG_RAX: 000000000000011d RAX: ffffffffffffffda RBX: 000000000055bf00 RCX: 0000000000465689 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000005 RBP: 00000000004af652 R08: 0000000000000000 R09: 0000000000000000 R10: 000000000000ffe0 R11: 0000000000000246 R12: 000000000055bf00 R13: 00007ffd08f4782f R14: 00007f3c1be60300 R15: 0000000000022000 INFO: task syz-executor.3:7333 blocked for more than 140 seconds. Not tainted 4.14.231-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D26440 7333 5765 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:00007fcd501c8188 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: 00007ffd4b8321df R14: 00007fcd501c8300 R15: 0000000000022000 INFO: task syz-executor.2:7339 blocked for more than 140 seconds. Not tainted 4.14.231-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D26440 7339 5756 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:00007f1c76f17188 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: 00007ffc05096b8f R14: 00007f1c76f17300 R15: 0000000000022000 INFO: task syz-executor.4:7362 blocked for more than 140 seconds. Not tainted 4.14.231-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.4 D26440 7362 5758 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:00007f7a354e8188 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: 00007fff17c3d71f R14: 00007f7a354e8300 R15: 0000000000022000 INFO: task syz-executor.5:7372 blocked for more than 140 seconds. Not tainted 4.14.231-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.5 D26440 7372 5763 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:00007fda4869c188 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: 00007ffff948520f R14: 00007fda4869c300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1069: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x79/0x218 kernel/locking/lockdep.c:4548 2 locks held by syz-executor.1/7134: #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/7269: #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/7333: #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/7339: #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/7362: #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/7372: #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: 1069 Comm: khungtaskd Not tainted 4.14.231-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 CPU: 0 PID: 29 Comm: kworker/u4:2 Not tainted 4.14.231-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: writeback wb_workfn (flush-7:1) task: ffff8881f4e82080 task.stack: ffff8881f4e88000 RIP: 0010:arch_local_irq_restore arch/x86/include/asm/paravirt.h:779 [inline] RIP: 0010:lock_release+0x446/0x820 kernel/locking/lockdep.c:4020 RSP: 0018:ffff8881f4e8f490 EFLAGS: 00000286 RAX: dffffc0000000000 RBX: 1ffff1103e9d1e95 RCX: 1ffff1103e9d051f RDX: 1ffffffff0fe2bd1 RSI: 0000000000000004 RDI: 0000000000000286 RBP: ffff8881f4e8f530 R08: 0000000000000001 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000000 R12: ffff8881f4e82080 R13: 0000000000000003 R14: ffff8881f4e82080 R15: ffff8881f4e82900 FS: 0000000000000000(0000) GS:ffff8881f6600000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f04d7daa020 CR3: 0000000007e6a003 CR4: 00000000001606f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: rcu_lock_release include/linux/rcupdate.h:247 [inline] rcu_read_unlock include/linux/rcupdate.h:685 [inline] unlocked_inode_to_wb_end include/linux/backing-dev.h:390 [inline] clear_page_dirty_for_io+0x6e6/0xa10 mm/page-writeback.c:2721 write_cache_pages+0x3ec/0xe50 mm/page-writeback.c:2253 generic_writepages mm/page-writeback.c:2346 [inline] generic_writepages+0xc1/0x110 mm/page-writeback.c:2335 blkdev_writepages+0x66/0xb0 fs/block_dev.c:1972 do_writepages+0xba/0x220 mm/page-writeback.c:2361 __writeback_single_inode+0xc6/0xda0 fs/fs-writeback.c:1377 writeback_sb_inodes+0x455/0xef0 fs/fs-writeback.c:1639 __writeback_inodes_wb+0xec/0x1e0 fs/fs-writeback.c:1708 wb_writeback+0x5e3/0x9f0 fs/fs-writeback.c:1814 wb_check_old_data_flush fs/fs-writeback.c:1927 [inline] wb_do_writeback fs/fs-writeback.c:1951 [inline] wb_workfn+0x803/0xe20 fs/fs-writeback.c:1980 process_one_work+0x74f/0x1620 kernel/workqueue.c:2116 worker_thread+0xcc/0xee0 kernel/workqueue.c:2250 kthread+0x338/0x400 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Code: 00 00 00 48 89 fa 48 c1 ea 03 80 3c 02 00 0f 85 1c 03 00 00 48 83 3d 91 5b ab 06 00 0f 84 cb 01 00 00 48 8b bd 68 ff ff ff 57 9d <0f> 1f 44 00 00 48 b8 00 00 00 00 00 fc ff df 48 01 c3 48 c7 03