Bluetooth: hci2 command 0x0406 tx timeout Bluetooth: hci1 command 0x0406 tx timeout Bluetooth: hci4 command 0x0406 tx timeout Bluetooth: hci3 command 0x0406 tx timeout Bluetooth: hci5 command 0x0406 tx timeout INFO: task syz-executor.1:9632 blocked for more than 140 seconds. Not tainted 4.14.281-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D28688 9632 8039 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 schedule_timeout+0x80a/0xe90 kernel/time/timer.c:1724 do_wait_for_common kernel/sched/completion.c:91 [inline] __wait_for_common kernel/sched/completion.c:112 [inline] wait_for_common+0x272/0x430 kernel/sched/completion.c:123 usb_start_wait_urb+0x125/0x440 drivers/usb/core/message.c:61 usb_bulk_msg+0x1f6/0x500 drivers/usb/core/message.c:252 proc_bulk+0x331/0x6d0 drivers/usb/core/devio.c:1223 usbdev_do_ioctl+0x5b0/0x2b70 drivers/usb/core/devio.c:2449 usbdev_ioctl+0x21/0x30 drivers/usb/core/devio.c:2599 vfs_ioctl fs/ioctl.c:46 [inline] file_ioctl fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 fs/ioctl.c:684 SYSC_ioctl fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7fb2b89d6109 RSP: 002b:00007fb2b734b168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 00007fb2b8ae8f60 RCX: 00007fb2b89d6109 RDX: 0000000020000180 RSI: 00000000c0185502 RDI: 0000000000000003 RBP: 00007fb2b8a3008d R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 R13: 00007ffc13de38df R14: 00007fb2b734b300 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 in:imklog/7733: #0: (&f->f_pos_lock){+.+.}, at: [] __fdget_pos+0x1fb/0x2b0 fs/file.c:819 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 1534 Comm: khungtaskd Not tainted 4.14.281-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 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 4625 Comm: systemd-journal Not tainted 4.14.281-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 task: ffff8880a1116180 task.stack: ffff8880a1118000 RIP: 0010:deref_stack_reg arch/x86/kernel/unwind_orc.c:289 [inline] RIP: 0010:deref_stack_reg+0x124/0x1a0 arch/x86/kernel/unwind_orc.c:283 RSP: 0018:ffff8880a111f740 EFLAGS: 00000087 RAX: ffff8880a111fcf8 RBX: 1ffff11014223ee9 RCX: ffffffff8a73a0de RDX: ffff8880a111f8b8 RSI: ffff8880a111f768 RDI: ffff8880a111fca8 RBP: ffff8880a111fca8 R08: 0000000000000001 R09: 0000000000000001 R10: ffff8880a111fcd8 R11: 0000000000000001 R12: ffff8880a111f878 R13: ffff8880a111f8b8 R14: ffff8880a1118000 R15: ffff8880a111f878 FS: 00007f615be2f8c0(0000) GS:ffff8880ba500000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f615923f020 CR3: 00000000a1798000 CR4: 00000000003406e0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: unwind_next_frame+0xfcc/0x17d0 arch/x86/kernel/unwind_orc.c:474 __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_slab_free+0xc3/0x1a0 mm/kasan/kasan.c:524 __cache_free mm/slab.c:3496 [inline] kfree+0xc9/0x250 mm/slab.c:3815 aa_free_file_ctx security/apparmor/include/file.h:76 [inline] apparmor_file_free_security+0x7e/0xb0 security/apparmor/lsm.c:441 security_file_free+0x42/0x80 security/security.c:879 put_filp+0x23/0x90 fs/file_table.c:312 path_openat+0x6ce/0x2970 fs/namei.c:3581 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:0x7f615b3be840 RSP: 002b:00007fffb993de68 EFLAGS: 00000246 ORIG_RAX: 0000000000000002 RAX: ffffffffffffffda RBX: 00007fffb993e170 RCX: 00007f615b3be840 RDX: 00000000000001a0 RSI: 0000000000080042 RDI: 0000559833a02450 RBP: 000000000000000d R08: 0000000000000000 R09: 00000000ffffffff R10: 0000000000000069 R11: 0000000000000246 R12: 00000000ffffffff R13: 00005598339f4040 R14: 00007fffb993e130 R15: 0000559833a024a0 Code: 00 49 8b 74 24 28 4c 89 e2 48 89 ef e8 d6 2a f8 ff 41 89 c0 31 c0 45 85 c0 75 32 48 8d 74 24 28 48 89 ef 4c 89 ea e8 cc fe ff ff <48> c1 ea 03 48 8b 6c 24 28 48 b8 00 00 00 00 00 fc ff df 80 3c ---------------- Code disassembly (best guess): 0: 00 49 8b add %cl,-0x75(%rcx) 3: 74 24 je 0x29 5: 28 4c 89 e2 sub %cl,-0x1e(%rcx,%rcx,4) 9: 48 89 ef mov %rbp,%rdi c: e8 d6 2a f8 ff callq 0xfff82ae7 11: 41 89 c0 mov %eax,%r8d 14: 31 c0 xor %eax,%eax 16: 45 85 c0 test %r8d,%r8d 19: 75 32 jne 0x4d 1b: 48 8d 74 24 28 lea 0x28(%rsp),%rsi 20: 48 89 ef mov %rbp,%rdi 23: 4c 89 ea mov %r13,%rdx 26: e8 cc fe ff ff callq 0xfffffef7 * 2b: 48 c1 ea 03 shr $0x3,%rdx <-- trapping instruction 2f: 48 8b 6c 24 28 mov 0x28(%rsp),%rbp 34: 48 b8 00 00 00 00 00 movabs $0xdffffc0000000000,%rax 3b: fc ff df 3e: 80 .byte 0x80 3f: 3c .byte 0x3c