Bluetooth: hci8 command 0x0409 tx timeout Bluetooth: hci6 command 0x0406 tx timeout Bluetooth: hci8 command 0x041b tx timeout Bluetooth: hci8 command 0x040f tx timeout Bluetooth: hci8 command 0x0419 tx timeout INFO: task syz-executor.2:11540 blocked for more than 140 seconds. Not tainted 4.14.290-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28552 11540 8003 0x00000004 Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 __rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:588 [inline] rwsem_down_write_failed+0x343/0x6d0 kernel/locking/rwsem-xadd.c:617 call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:105 __down_write arch/x86/include/asm/rwsem.h:126 [inline] down_write+0x4f/0x90 kernel/locking/rwsem.c:56 inode_lock include/linux/fs.h:719 [inline] fuse_flush+0x1c7/0x520 fs/fuse/file.c:423 filp_close+0x9d/0x140 fs/open.c:1158 do_dup2+0x1ec/0x3d0 fs/file.c:896 SYSC_dup3 fs/file.c:952 [inline] SyS_dup3+0x218/0x360 fs/file.c:927 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7ff35e88a279 RSP: 002b:00007ff35d1ff168 EFLAGS: 00000246 ORIG_RAX: 0000000000000124 RAX: ffffffffffffffda RBX: 00007ff35e99cf80 RCX: 00007ff35e88a279 RDX: 0000000000000000 RSI: 0000000000000005 RDI: 0000000000000004 RBP: 00007ff35e8e4189 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffc1af3065f R14: 00007ff35d1ff300 R15: 0000000000022000 INFO: task syz-executor.2:11562 blocked for more than 140 seconds. Not tainted 4.14.290-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28696 11562 8003 0x00000004 Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 fuse_wait_on_page_writeback fs/fuse/file.c:385 [inline] fuse_wait_on_page_writeback.isra.0+0xdc/0x120 fs/fuse/file.c:381 fuse_launder_page fs/fuse/file.c:2042 [inline] fuse_launder_page+0xa2/0xd0 fs/fuse/file.c:2035 do_launder_page mm/truncate.c:609 [inline] invalidate_inode_pages2_range+0x547/0xc00 mm/truncate.c:685 fuse_finish_open+0x262/0x500 fs/fuse/file.c:181 fuse_open_common+0x234/0x290 fs/fuse/file.c:224 do_dentry_open+0x44b/0xec0 fs/open.c:777 vfs_open+0x105/0x220 fs/open.c:888 do_last fs/namei.c:3428 [inline] path_openat+0x628/0x2970 fs/namei.c:3569 do_filp_open+0x179/0x3c0 fs/namei.c:3603 do_sys_open+0x296/0x410 fs/open.c:1081 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7ff35e88a279 RSP: 002b:00007ff35d1de168 EFLAGS: 00000246 ORIG_RAX: 0000000000000055 RAX: ffffffffffffffda RBX: 00007ff35e99d050 RCX: 00007ff35e88a279 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000140 RBP: 00007ff35e8e4189 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffc1af3065f R14: 00007ff35d1de300 R15: 0000000000022000 INFO: task syz-executor.2:11856 blocked for more than 140 seconds. Not tainted 4.14.290-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28136 11856 11615 0x00000004 Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 __rwsem_down_write_failed_common kernel/locking/rwsem-xadd.c:588 [inline] rwsem_down_write_failed+0x343/0x6d0 kernel/locking/rwsem-xadd.c:617 call_rwsem_down_write_failed+0x13/0x20 arch/x86/lib/rwsem.S:105 __down_write arch/x86/include/asm/rwsem.h:126 [inline] down_write+0x4f/0x90 kernel/locking/rwsem.c:56 inode_lock include/linux/fs.h:719 [inline] fuse_flush+0x1c7/0x520 fs/fuse/file.c:423 filp_close+0x9d/0x140 fs/open.c:1158 do_dup2+0x1ec/0x3d0 fs/file.c:896 SYSC_dup3 fs/file.c:952 [inline] SyS_dup3+0x218/0x360 fs/file.c:927 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7fe77cc71279 RSP: 002b:00007fe77b5e6168 EFLAGS: 00000246 ORIG_RAX: 0000000000000124 RAX: ffffffffffffffda RBX: 00007fe77cd83f80 RCX: 00007fe77cc71279 RDX: 0000000000000000 RSI: 0000000000000005 RDI: 0000000000000004 RBP: 00007fe77cccb189 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffec8cd074f R14: 00007fe77b5e6300 R15: 0000000000022000 INFO: task syz-executor.2:11860 blocked for more than 140 seconds. Not tainted 4.14.290-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D29136 11860 11615 0x00000004 Call Trace: context_switch kernel/sched/core.c:2811 [inline] __schedule+0x88b/0x1de0 kernel/sched/core.c:3387 schedule+0x8d/0x1b0 kernel/sched/core.c:3431 fuse_wait_on_page_writeback fs/fuse/file.c:385 [inline] fuse_wait_on_page_writeback.isra.0+0xdc/0x120 fs/fuse/file.c:381 fuse_launder_page fs/fuse/file.c:2042 [inline] fuse_launder_page+0xa2/0xd0 fs/fuse/file.c:2035 do_launder_page mm/truncate.c:609 [inline] invalidate_inode_pages2_range+0x547/0xc00 mm/truncate.c:685 fuse_finish_open+0x262/0x500 fs/fuse/file.c:181 fuse_open_common+0x234/0x290 fs/fuse/file.c:224 do_dentry_open+0x44b/0xec0 fs/open.c:777 vfs_open+0x105/0x220 fs/open.c:888 do_last fs/namei.c:3428 [inline] path_openat+0x628/0x2970 fs/namei.c:3569 do_filp_open+0x179/0x3c0 fs/namei.c:3603 do_sys_open+0x296/0x410 fs/open.c:1081 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7fe77cc71279 RSP: 002b:00007fe77b5c5168 EFLAGS: 00000246 ORIG_RAX: 0000000000000055 RAX: ffffffffffffffda RBX: 00007fe77cd84050 RCX: 00007fe77cc71279 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000020000140 RBP: 00007fe77cccb189 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffec8cd074f R14: 00007fe77b5c5300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1534: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548 1 lock held by syz-executor.2/11540: #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_flush+0x1c7/0x520 fs/fuse/file.c:423 2 locks held by syz-executor.2/11562: #0: (sb_writers#13){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] #0: (sb_writers#13){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_open_common+0x1a4/0x290 fs/fuse/file.c:217 1 lock held by syz-executor.2/11856: #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_flush+0x1c7/0x520 fs/fuse/file.c:423 2 locks held by syz-executor.2/11860: #0: (sb_writers#13){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] #0: (sb_writers#13){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_open_common+0x1a4/0x290 fs/fuse/file.c:217 1 lock held by syz-executor.2/12139: #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_flush+0x1c7/0x520 fs/fuse/file.c:423 2 locks held by syz-executor.2/12143: #0: (sb_writers#13){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] #0: (sb_writers#13){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_open_common+0x1a4/0x290 fs/fuse/file.c:217 1 lock held by syz-executor.2/12424: #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #0: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_flush+0x1c7/0x520 fs/fuse/file.c:423 2 locks held by syz-executor.2/12427: #0: (sb_writers#13){.+.+}, at: [] sb_start_write include/linux/fs.h:1551 [inline] #0: (sb_writers#13){.+.+}, at: [] mnt_want_write+0x3a/0xb0 fs/namespace.c:386 #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] inode_lock include/linux/fs.h:719 [inline] #1: (&sb->s_type->i_mutex_key#21){+.+.}, at: [] fuse_open_common+0x1a4/0x290 fs/fuse/file.c:217 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 1534 Comm: khungtaskd Not tainted 4.14.290-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/2022 Call Trace: __dump_stack lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x180 lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:195 [inline] watchdog+0x5b9/0xb40 kernel/hung_task.c:274 kthread+0x30d/0x420 kernel/kthread.c:232 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:404 Sending NMI from CPU 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 4625 Comm: systemd-journal Not tainted 4.14.290-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/2022 task: ffff8880a106a180 task.stack: ffff8880a1070000 RIP: 0010:memcmp+0x20/0xb0 lib/string.c:917 RSP: 0018:ffff8880a1077800 EFLAGS: 00000246 RAX: 0000000000000000 RBX: ffff8880a10778d6 RCX: 0000000000000006 RDX: 00000000000000ff RSI: ffff8880a4368ede RDI: ffff8880a10778a0 RBP: dffffc0000000000 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: ffff8880a106a180 R12: ffff8880a10778f0 R13: 000000000000000a R14: ffff8880a10778a0 R15: ffff8880a4368e90 FS: 00007f5ea354a8c0(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f5ea09eb020 CR3: 00000000a1149000 CR4: 00000000003406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: find_stack lib/stackdepot.c:180 [inline] depot_save_stack+0x10d/0x3f0 lib/stackdepot.c:229 save_stack mm/kasan/kasan.c:453 [inline] set_track mm/kasan/kasan.c:459 [inline] kasan_kmalloc+0x139/0x160 mm/kasan/kasan.c:551 kmem_cache_alloc_trace+0x131/0x3d0 mm/slab.c:3618 kmalloc include/linux/slab.h:488 [inline] kzalloc include/linux/slab.h:661 [inline] aa_alloc_file_ctx security/apparmor/include/file.h:60 [inline] apparmor_file_alloc_security+0x129/0x800 security/apparmor/lsm.c:431 security_file_alloc+0x66/0xa0 security/security.c:874 get_empty_filp+0x16b/0x3f0 fs/file_table.c:129 path_openat+0x84/0x2970 fs/namei.c:3545 do_filp_open+0x179/0x3c0 fs/namei.c:3603 do_sys_open+0x296/0x410 fs/open.c:1081 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7f5ea2ad9840 RSP: 002b:00007ffec64fc2d8 EFLAGS: 00000246 ORIG_RAX: 0000000000000002 RAX: ffffffffffffffda RBX: 00007ffec64fc5e0 RCX: 00007f5ea2ad9840 RDX: 00000000000001a0 RSI: 0000000000080042 RDI: 000055c9d815c5a0 RBP: 000000000000000d R08: 000000000000c0ff R09: 00000000ffffffff R10: 0000000000000069 R11: 0000000000000246 R12: 00000000ffffffff R13: 000055c9d814e040 R14: 00007ffec64fc5a0 R15: 000055c9d815b3f0 Code: 04 24 eb d7 0f 1f 80 00 00 00 00 48 85 d2 74 78 41 54 4c 8d 24 17 55 48 bd 00 00 00 00 00 fc ff df 53 48 89 fb 48 83 ec 10 eb 0d <48> 83 c3 01 48 83 c6 01 49 39 dc 74 45 48 89 d8 48 89 da 48 c1