Bluetooth: hci0 command 0x0409 tx timeout Bluetooth: hci0 command 0x041b tx timeout Bluetooth: hci0 command 0x040f tx timeout Bluetooth: hci0 command 0x0419 tx timeout Bluetooth: hci0 command 0x0406 tx timeout INFO: task syz-executor.0:8237 blocked for more than 140 seconds. Not tainted 4.14.218-syzkaller #0 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D27848 8237 7990 0x00000004 Call Trace: context_switch syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:2808 [inline] __schedule+0x88b/0x1de0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3384 schedule+0x8d/0x1b0 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3428 schedule_timeout+0x80a/0xe90 syzkaller/managers/linux-4-14/kernel/kernel/time/timer.c:1724 do_wait_for_common syzkaller/managers/linux-4-14/kernel/kernel/sched/completion.c:91 [inline] __wait_for_common syzkaller/managers/linux-4-14/kernel/kernel/sched/completion.c:112 [inline] wait_for_common+0x272/0x430 syzkaller/managers/linux-4-14/kernel/kernel/sched/completion.c:123 usb_start_wait_urb+0x125/0x440 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:61 usb_bulk_msg+0x1f6/0x500 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/message.c:252 proc_bulk+0x331/0x6d0 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/devio.c:1223 usbdev_do_ioctl+0x5b0/0x2b70 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/devio.c:2449 usbdev_ioctl+0x21/0x30 syzkaller/managers/linux-4-14/kernel/drivers/usb/core/devio.c:2599 vfs_ioctl syzkaller/managers/linux-4-14/kernel/fs/ioctl.c:46 [inline] file_ioctl syzkaller/managers/linux-4-14/kernel/fs/ioctl.c:500 [inline] do_vfs_ioctl+0x75a/0xff0 syzkaller/managers/linux-4-14/kernel/fs/ioctl.c:684 SYSC_ioctl syzkaller/managers/linux-4-14/kernel/fs/ioctl.c:701 [inline] SyS_ioctl+0x7f/0xb0 syzkaller/managers/linux-4-14/kernel/fs/ioctl.c:692 do_syscall_64+0x1d5/0x640 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x465b09 RSP: 002b:00007f4d358eb188 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 RAX: ffffffffffffffda RBX: 000000000056bf60 RCX: 0000000000465b09 RDX: 0000000020000340 RSI: 00000000c0185502 RDI: 0000000000000004 RBP: 00000000004b069f R08: 0000000000000000 R09: 0000000000000000 R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf60 R13: 00007ffd9a94779f R14: 00007f4d358eb300 R15: 0000000000022000 Showing all locks held in the system: 1 lock held by khungtaskd/1531: #0: (tasklist_lock){.+.+}, at: [] debug_show_all_locks+0x7c/0x21a syzkaller/managers/linux-4-14/kernel/kernel/locking/lockdep.c:4548 1 lock held by in:imklog/7681: #0: (&f->f_pos_lock){+.+.}, at: [] __fdget_pos+0x1fb/0x2b0 syzkaller/managers/linux-4-14/kernel/fs/file.c:769 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1531 Comm: khungtaskd Not tainted 4.14.218-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack syzkaller/managers/linux-4-14/kernel/lib/dump_stack.c:17 [inline] dump_stack+0x1b2/0x281 syzkaller/managers/linux-4-14/kernel/lib/dump_stack.c:58 nmi_cpu_backtrace.cold+0x57/0x93 syzkaller/managers/linux-4-14/kernel/lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x13a/0x180 syzkaller/managers/linux-4-14/kernel/lib/nmi_backtrace.c:62 trigger_all_cpu_backtrace syzkaller/managers/linux-4-14/kernel/./include/linux/nmi.h:140 [inline] check_hung_uninterruptible_tasks syzkaller/managers/linux-4-14/kernel/kernel/hung_task.c:195 [inline] watchdog+0x5b9/0xb40 syzkaller/managers/linux-4-14/kernel/kernel/hung_task.c:274 kthread+0x30d/0x420 syzkaller/managers/linux-4-14/kernel/kernel/kthread.c:232 ret_from_fork+0x24/0x30 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/entry_64.S:404 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 4623 Comm: systemd-journal Not tainted 4.14.218-syzkaller #0 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 task: ffff8880a12a2100 task.stack: ffff8880a12a8000 RIP: 0010:get_lock_parent_ip syzkaller/managers/linux-4-14/kernel/./include/linux/ftrace.h:730 [inline] RIP: 0010:preempt_latency_start syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3085 [inline] RIP: 0010:preempt_count_add+0xaf/0x170 syzkaller/managers/linux-4-14/kernel/kernel/sched/core.c:3110 RSP: 0018:ffff8880a12afa00 EFLAGS: 00000297 RAX: 0000000000000000 RBX: ffffffff81236042 RCX: 0000000000000000 RDX: 0000000000000000 RSI: ffff8880a12af9c8 RDI: ffffffff81236042 RBP: 0000000000000001 R08: 0000000000000001 R09: 0000000000000001 R10: ffff8880a12afe30 R11: 0000000000000001 R12: ffff8880a12afb60 R13: ffff8880a12afb10 R14: ffff88823f8bb200 R15: ffff8880a12afad8 FS: 00007f64bdcff8c0(0000) GS:ffff8880ba400000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007f64bb0d8028 CR3: 00000000a104b000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: unwind_next_frame+0xc2/0x17d0 syzkaller/managers/linux-4-14/kernel/arch/x86/kernel/unwind_orc.c:333 __save_stack_trace+0x90/0x160 syzkaller/managers/linux-4-14/kernel/arch/x86/kernel/stacktrace.c:44 save_stack syzkaller/managers/linux-4-14/kernel/mm/kasan/kasan.c:447 [inline] set_track syzkaller/managers/linux-4-14/kernel/mm/kasan/kasan.c:459 [inline] kasan_kmalloc+0xeb/0x160 syzkaller/managers/linux-4-14/kernel/mm/kasan/kasan.c:551 kmem_cache_alloc+0x124/0x3c0 syzkaller/managers/linux-4-14/kernel/mm/slab.c:3552 getname_flags+0xc8/0x550 syzkaller/managers/linux-4-14/kernel/fs/namei.c:138 user_path_at_empty+0x2a/0x50 syzkaller/managers/linux-4-14/kernel/fs/namei.c:2631 user_path_at syzkaller/managers/linux-4-14/kernel/./include/linux/namei.h:57 [inline] SYSC_faccessat syzkaller/managers/linux-4-14/kernel/fs/open.c:403 [inline] SyS_faccessat+0x21b/0x680 syzkaller/managers/linux-4-14/kernel/fs/open.c:353 do_syscall_64+0x1d5/0x640 syzkaller/managers/linux-4-14/kernel/arch/x86/entry/common.c:292 entry_SYSCALL_64_after_hwframe+0x46/0xbb RIP: 0033:0x7f64bcfbb9c7 RSP: 002b:00007fff0418f758 EFLAGS: 00000246 ORIG_RAX: 0000000000000015 RAX: ffffffffffffffda RBX: 00007fff04192780 RCX: 00007f64bcfbb9c7 RDX: 0000000000000000 RSI: 0000000000000000 RDI: 000055eb1d6e19a3 RBP: 00007fff0418f8a0 R08: 000055eb1d6d73e5 R09: 0000000000000018 R10: 0000000000000069 R11: 0000000000000246 R12: 0000000000000000 R13: 0000000000000000 R14: 000055eb1ec9e8a0 R15: 00007fff0418fd90 Code: 7e 0f b6 c0 3d f4 00 00 00 7f 60 65 8b 05 8a d3 c8 7e 25 ff ff ff 7f 39 c5 74 03 5b 5d c3 48 8b 5c 24 10 48 89 df e8 51 da 08 00 <85> c0 75 31 65 48 8b 2c 25 80 df 01 00 48 8d bd 38 12 00 00 48