Bluetooth: hci4 command 0x0406 tx timeout Bluetooth: hci5 command 0x0406 tx timeout Bluetooth: hci0 command 0x0406 tx timeout Bluetooth: hci3 command 0x0406 tx timeout Bluetooth: hci2 command 0x0406 tx timeout INFO: task syz-executor.3:9972 blocked for more than 140 seconds. Not tainted 4.14.277-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D28912 9972 8010 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 __close_fd+0x151/0x230 fs/file.c:639 SYSC_close fs/open.c:1177 [inline] SyS_close+0x42/0x90 fs/open.c:1175 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7f0f50c0fd2b RSP: 002b:00007fff6e4994c0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 00007f0f50c0fd2b RDX: 0000001b30120000 RSI: 0000001b30125aac RDI: 0000000000000004 RBP: 00007f0f50d71960 R08: 0000000000000000 R09: 000000004770aae7 R10: 001dbe244caa3dad R11: 0000000000000293 R12: 0000000000021b0d R13: 00007fff6e4995c0 R14: 00007f0f50d70030 R15: 0000000000000032 INFO: task syz-executor.3:9977 blocked for more than 140 seconds. Not tainted 4.14.277-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D28536 9977 8010 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:0x7f0f50c5d0e9 RSP: 002b:00007f0f4f5d2168 EFLAGS: 00000246 ORIG_RAX: 0000000000000055 RAX: ffffffffffffffda RBX: 00007f0f50d6ff60 RCX: 00007f0f50c5d0e9 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 00000000200001c0 RBP: 00007f0f50cb708d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007fff6e49945f R14: 00007f0f4f5d2300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1522: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a kernel/locking/lockdep.c:4548 1 lock held by in:imklog/7687: #0: (&f->f_pos_lock){+.+.}, at: [] __fdget_pos+0x1fb/0x2b0 fs/file.c:819 1 lock held by syz-executor.3/9972: #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.3/9977: #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 1 CPU: 1 PID: 1522 Comm: khungtaskd Not tainted 4.14.277-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+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 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 4621 Comm: systemd-journal Not tainted 4.14.277-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 task: ffff8880a1740080 task.stack: ffff8880a1748000 RIP: 0010:preempt_latency_start kernel/sched/core.c:3090 [inline] RIP: 0010:preempt_count_add+0xd8/0x170 kernel/sched/core.c:3113 RSP: 0018:ffff8880a174fa48 EFLAGS: 00000246 RAX: dffffc0000000000 RBX: ffffffff81237042 RCX: 0000000000000000 RDX: 1ffff110142e8257 RSI: ffff8880a174fa10 RDI: ffff8880a17412b8 RBP: ffff8880a1740080 R08: 0000000000000001 R09: 0000000000000001 R10: ffff8880a174ff58 R11: 0000000000000001 R12: ffff8880a174fba8 R13: ffff8880a174fb58 R14: ffff88823f8bb200 R15: ffff8880a174fb20 FS: 00007f375fff38c0(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f375d409000 CR3: 00000000a164d000 CR4: 00000000003406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: unwind_next_frame+0xc2/0x17d0 arch/x86/kernel/unwind_orc.c:333 __save_stack_trace+0x90/0x160 arch/x86/kernel/stacktrace.c:44 save_stack mm/kasan/kasan.c:447 [inline] set_track mm/kasan/kasan.c:459 [inline] kasan_kmalloc+0xeb/0x160 mm/kasan/kasan.c:551 slab_post_alloc_hook mm/slab.h:442 [inline] slab_alloc mm/slab.c:3390 [inline] kmem_cache_alloc+0x111/0x3c0 mm/slab.c:3550 getname_flags+0xc8/0x550 fs/namei.c:138 getname fs/namei.c:209 [inline] user_path_create fs/namei.c:3732 [inline] SYSC_mkdirat fs/namei.c:3864 [inline] SyS_mkdirat+0x83/0x270 fs/namei.c:3856 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7f375f2ae687 RSP: 002b:00007ffd5c95b188 EFLAGS: 00000293 ORIG_RAX: 0000000000000053 RAX: ffffffffffffffda RBX: 00007ffd5c95e0a0 RCX: 00007f375f2ae687 RDX: 00007f375fd1fa00 RSI: 00000000000001ed RDI: 000055bc5e1be8a0 RBP: 00007ffd5c95b1c0 R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000069 R11: 0000000000000293 R12: 0000000000000000 R13: 0000000000000000 R14: 00007ffd5c95e0a0 R15: 00007ffd5c95b6b0 Code: 08 00 85 c0 75 31 65 48 8b 2c 25 c0 7f 02 00 48 8d bd 38 12 00 00 48 b8 00 00 00 00 00 fc ff df 48 89 fa 48 c1 ea 03 80 3c 02 00 <75> 79 48 89 9d 38 12 00 00 5b 5d c3 31 ff 31 db e8 e3 d9 08 00 ---------------- Code disassembly (best guess): 0: 08 00 or %al,(%rax) 2: 85 c0 test %eax,%eax 4: 75 31 jne 0x37 6: 65 48 8b 2c 25 c0 7f mov %gs:0x27fc0,%rbp d: 02 00 f: 48 8d bd 38 12 00 00 lea 0x1238(%rbp),%rdi 16: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax 1d: fc ff df 20: 48 89 fa mov %rdi,%rdx 23: 48 c1 ea 03 shr $0x3,%rdx 27: 80 3c 02 00 cmpb $0x0,(%rdx,%rax,1) * 2b: 75 79 jne 0xa6 <-- trapping instruction 2d: 48 89 9d 38 12 00 00 mov %rbx,0x1238(%rbp) 34: 5b pop %rbx 35: 5d pop %rbp 36: c3 retq 37: 31 ff xor %edi,%edi 39: 31 db xor %ebx,%ebx 3b: e8 e3 d9 08 00 callq 0x8da23