[ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... [ OK ] Started Update UTMP about System Runlevel Changes. Starting Load/Save RF Kill Switch Status... [ OK ] Started Load/Save RF Kill Switch Status. Debian GNU/Linux 9 syzkaller ttyS0 Warning: Permanently added '10.128.1.32' (ECDSA) to the list of known hosts. executing program syzkaller login: [ 485.217883][ T5] Bluetooth: hci0: command 0x0409 tx timeout [ 487.297670][ T5] Bluetooth: hci0: command 0x041b tx timeout [ 489.377503][ T5] Bluetooth: hci0: command 0x040f tx timeout [ 491.457352][ T5] Bluetooth: hci0: command 0x0419 tx timeout [ 493.537088][ T5] Bluetooth: hci0: command 0x0405 tx timeout [ 605.528424][ T5] Bluetooth: hci0: command 0x0406 tx timeout [ 716.082520][ T27] INFO: task krfcommd:2892 blocked for more than 143 seconds. [ 716.090018][ T27] Not tainted 5.14.0-rc5-next-20210813-syzkaller #0 [ 716.097933][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 716.106713][ T27] task:krfcommd state:D stack:29600 pid: 2892 ppid: 2 flags:0x00004000 [ 716.116013][ T27] Call Trace: [ 716.119399][ T27] __schedule+0x93a/0x26f0 [ 716.124239][ T27] ? io_schedule_timeout+0x140/0x140 [ 716.129639][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 716.134969][ T27] schedule+0xd3/0x270 [ 716.139051][ T27] schedule_preempt_disabled+0xf/0x20 [ 716.144768][ T27] __mutex_lock+0xa46/0x1300 [ 716.149380][ T27] ? rfcomm_run+0x2ed/0x4a20 [ 716.154319][ T27] ? mutex_lock_io_nested+0x1160/0x1160 [ 716.159881][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.165014][ T27] rfcomm_run+0x2ed/0x4a20 [ 716.169467][ T27] ? find_held_lock+0x2d/0x110 [ 716.174607][ T27] ? rfcomm_check_accept+0x240/0x240 [ 716.179951][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.185117][ T27] ? __init_waitqueue_head+0xd0/0xd0 [ 716.190486][ T27] ? _raw_spin_unlock_irqrestore+0x50/0x70 [ 716.196683][ T27] ? lockdep_hardirqs_on+0x79/0x100 [ 716.201893][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 716.208553][ T27] ? __kthread_parkme+0x15f/0x220 [ 716.213736][ T27] ? rfcomm_check_accept+0x240/0x240 [ 716.219040][ T27] kthread+0x3e5/0x4d0 [ 716.223343][ T27] ? set_kthread_struct+0x130/0x130 [ 716.228557][ T27] ret_from_fork+0x1f/0x30 [ 716.233359][ T27] INFO: task syz-executor392:6611 blocked for more than 143 seconds. [ 716.241438][ T27] Not tainted 5.14.0-rc5-next-20210813-syzkaller #0 [ 716.248898][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 716.257630][ T27] task:syz-executor392 state:D stack:28184 pid: 6611 ppid: 6578 flags:0x00004006 [ 716.267231][ T27] Call Trace: [ 716.270518][ T27] __schedule+0x93a/0x26f0 [ 716.275006][ T27] ? io_schedule_timeout+0x140/0x140 [ 716.280294][ T27] ? trace_hardirqs_on+0x5b/0x1c0 [ 716.285444][ T27] ? _raw_spin_unlock_irqrestore+0x3d/0x70 [ 716.291255][ T27] schedule+0xd3/0x270 [ 716.295393][ T27] __lock_sock+0x13d/0x260 [ 716.299866][ T27] ? sock_omalloc+0x180/0x180 [ 716.304581][ T27] ? __rfcomm_dlc_close+0x162/0x8a0 [ 716.309867][ T27] ? finish_wait+0x270/0x270 [ 716.314537][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 716.319493][ T27] lock_sock_nested+0xf6/0x120 [ 716.324297][ T27] rfcomm_sk_state_change+0xb4/0x390 [ 716.329731][ T27] __rfcomm_dlc_close+0x1b6/0x8a0 [ 716.334846][ T27] rfcomm_dlc_close+0x1ea/0x240 [ 716.339715][ T27] __rfcomm_sock_close+0xac/0x260 [ 716.344791][ T27] rfcomm_sock_shutdown+0xe9/0x210 [ 716.349998][ T27] rfcomm_sock_release+0x5f/0x140 [ 716.355096][ T27] __sock_release+0xcd/0x280 [ 716.359766][ T27] sock_close+0x18/0x20 [ 716.363950][ T27] __fput+0x288/0x9f0 [ 716.368284][ T27] ? __sock_release+0x280/0x280 [ 716.373213][ T27] task_work_run+0xdd/0x1a0 [ 716.377803][ T27] do_exit+0xbae/0x2a30 [ 716.382084][ T27] ? lock_acquire+0x442/0x510 [ 716.386844][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 716.392437][ T27] ? lock_release+0x522/0x720 [ 716.397121][ T27] ? mm_update_next_owner+0x7a0/0x7a0 [ 716.403119][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.407961][ T27] ? do_raw_spin_lock+0x120/0x2b0 [ 716.413564][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 716.418489][ T27] do_group_exit+0x125/0x310 [ 716.423636][ T27] get_signal+0x47f/0x2160 [ 716.428106][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.433512][ T27] ? wake_up_q+0xf0/0xf0 [ 716.437784][ T27] arch_do_signal_or_restart+0x2a9/0x1c40 [ 716.444151][ T27] ? rfcomm_sock_connect+0x15f/0x460 [ 716.449434][ T27] ? rfcomm_sock_getname+0x300/0x300 [ 716.455741][ T27] ? __sys_connect_file+0x4e/0x1a0 [ 716.460854][ T27] ? get_sigframe_size+0x10/0x10 [ 716.466454][ T27] ? __sys_connect_file+0x1a0/0x1a0 [ 716.471658][ T27] exit_to_user_mode_prepare+0x17d/0x290 [ 716.477931][ T27] syscall_exit_to_user_mode+0x19/0x60 [ 716.483779][ T27] do_syscall_64+0x42/0xb0 [ 716.488246][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 716.494235][ T27] RIP: 0033:0x445fe9 [ 716.498121][ T27] RSP: 002b:00007ffc9a572568 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 716.506561][ T27] RAX: fffffffffffffffc RBX: 0000000000000003 RCX: 0000000000445fe9 [ 716.514601][ T27] RDX: 0000000000000080 RSI: 0000000020000600 RDI: 0000000000000004 [ 716.522596][ T27] RBP: 0000000000000003 R08: 000000ff00000001 R09: 000000ff00000001 [ 716.530566][ T27] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000138c2b8 [ 716.538603][ T27] R13: 0000000000000072 R14: 00007ffc9a5725c0 R15: 0000000000000003 [ 716.546633][ T27] INFO: lockdep is turned off. [ 716.551381][ T27] NMI backtrace for cpu 1 [ 716.555719][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.14.0-rc5-next-20210813-syzkaller #0 [ 716.565062][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 716.575134][ T27] Call Trace: [ 716.578396][ T27] dump_stack_lvl+0xcd/0x134 [ 716.583020][ T27] nmi_cpu_backtrace.cold+0x47/0x144 [ 716.588287][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 716.593517][ T27] nmi_trigger_cpumask_backtrace+0x1ae/0x220 [ 716.599532][ T27] watchdog+0xcb7/0xed0 [ 716.603695][ T27] ? trace_sched_process_hang+0x280/0x280 [ 716.609415][ T27] kthread+0x3e5/0x4d0 [ 716.613480][ T27] ? set_kthread_struct+0x130/0x130 [ 716.618660][ T27] ret_from_fork+0x1f/0x30 [ 716.623516][ T27] Sending NMI from CPU 1 to CPUs 0: [ 716.628741][ C0] NMI backtrace for cpu 0 skipped: idling at acpi_idle_do_entry+0x1c6/0x250 [ 716.629723][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 716.645194][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.14.0-rc5-next-20210813-syzkaller #0 [ 716.654560][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 716.664604][ T27] Call Trace: [ 716.667893][ T27] dump_stack_lvl+0xcd/0x134 [ 716.672483][ T27] panic+0x2b0/0x6dd [ 716.676406][ T27] ? __warn_printk+0xf3/0xf3 [ 716.680992][ T27] ? native_safe_apic_wait_icr_idle+0x65/0x90 [ 716.687069][ T27] ? watchdog.cold+0x1b9/0x1de [ 716.691848][ T27] watchdog.cold+0x1ca/0x1de [ 716.696434][ T27] ? trace_sched_process_hang+0x280/0x280 [ 716.702167][ T27] kthread+0x3e5/0x4d0 [ 716.706258][ T27] ? set_kthread_struct+0x130/0x130 [ 716.711459][ T27] ret_from_fork+0x1f/0x30 [ 716.717171][ T27] Kernel Offset: disabled [ 716.721487][ T27] Rebooting in 86400 seconds..