[ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... Starting Load/Save RF Kill Switch Status... [ OK ] Started Update UTMP about System Runlevel Changes. [ OK ] Started Load/Save RF Kill Switch Status. Debian GNU/Linux 9 syzkaller ttyS0 Warning: Permanently added '10.128.1.87' (ECDSA) to the list of known hosts. executing program syzkaller login: [ 486.251605][ T2991] Bluetooth: hci0: command 0x0409 tx timeout [ 488.331366][ T2991] Bluetooth: hci0: command 0x041b tx timeout [ 490.411220][ T6598] Bluetooth: hci0: command 0x040f tx timeout [ 492.490924][ T6598] Bluetooth: hci0: command 0x0419 tx timeout [ 494.570728][ T6598] Bluetooth: hci0: command 0x0405 tx timeout [ 610.640605][ T6598] Bluetooth: hci0: command 0x0406 tx timeout [ 716.074272][ T27] INFO: task krfcommd:2893 blocked for more than 143 seconds. [ 716.081742][ T27] Not tainted 5.14.0-rc5-next-20210812-syzkaller #0 [ 716.089689][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 716.098423][ T27] task:krfcommd state:D stack:29640 pid: 2893 ppid: 2 flags:0x00004000 [ 716.107692][ T27] Call Trace: [ 716.111007][ T27] __schedule+0x93a/0x26f0 [ 716.115750][ T27] ? io_schedule_timeout+0x140/0x140 [ 716.121051][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 716.126292][ T27] schedule+0xd3/0x270 [ 716.130372][ T27] schedule_preempt_disabled+0xf/0x20 [ 716.136090][ T27] __mutex_lock+0xa46/0x1300 [ 716.140706][ T27] ? rfcomm_run+0x2ed/0x4a20 [ 716.145648][ T27] ? mutex_lock_io_nested+0x1160/0x1160 [ 716.151267][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.156364][ T27] rfcomm_run+0x2ed/0x4a20 [ 716.160792][ T27] ? find_held_lock+0x2d/0x110 [ 716.165793][ T27] ? rfcomm_check_accept+0x240/0x240 [ 716.171087][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.176206][ T27] ? __init_waitqueue_head+0xd0/0xd0 [ 716.181499][ T27] ? _raw_spin_unlock_irqrestore+0x50/0x70 [ 716.187554][ T27] ? lockdep_hardirqs_on+0x79/0x100 [ 716.192759][ T27] ? __sanitizer_cov_trace_const_cmp1+0x22/0x80 [ 716.199579][ T27] ? __kthread_parkme+0x15f/0x220 [ 716.204935][ T27] ? rfcomm_check_accept+0x240/0x240 [ 716.210277][ T27] kthread+0x3e5/0x4d0 [ 716.214601][ T27] ? set_kthread_struct+0x130/0x130 [ 716.219814][ T27] ret_from_fork+0x1f/0x30 [ 716.224512][ T27] INFO: task syz-executor439:6591 blocked for more than 143 seconds. [ 716.232574][ T27] Not tainted 5.14.0-rc5-next-20210812-syzkaller #0 [ 716.240046][ T27] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 716.248777][ T27] task:syz-executor439 state:D stack:27704 pid: 6591 ppid: 6564 flags:0x00004006 [ 716.258043][ T27] Call Trace: [ 716.261321][ T27] __schedule+0x93a/0x26f0 [ 716.265985][ T27] ? io_schedule_timeout+0x140/0x140 [ 716.271320][ T27] ? trace_hardirqs_on+0x5b/0x1c0 [ 716.276609][ T27] ? _raw_spin_unlock_irqrestore+0x3d/0x70 [ 716.282424][ T27] schedule+0xd3/0x270 [ 716.286716][ T27] __lock_sock+0x13d/0x260 [ 716.291217][ T27] ? sock_omalloc+0x180/0x180 [ 716.296095][ T27] ? __rfcomm_dlc_close+0x162/0x8a0 [ 716.301399][ T27] ? finish_wait+0x270/0x270 [ 716.306669][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 716.311625][ T27] lock_sock_nested+0xf6/0x120 [ 716.316615][ T27] rfcomm_sk_state_change+0xb4/0x390 [ 716.321973][ T27] __rfcomm_dlc_close+0x1b6/0x8a0 [ 716.327244][ T27] rfcomm_dlc_close+0x1ea/0x240 [ 716.332113][ T27] __rfcomm_sock_close+0xac/0x260 [ 716.337344][ T27] rfcomm_sock_shutdown+0xe9/0x210 [ 716.342465][ T27] rfcomm_sock_release+0x5f/0x140 [ 716.347707][ T27] __sock_release+0xcd/0x280 [ 716.352721][ T27] sock_close+0x18/0x20 [ 716.357089][ T27] __fput+0x288/0x9f0 [ 716.361125][ T27] ? __sock_release+0x280/0x280 [ 716.366190][ T27] task_work_run+0xdd/0x1a0 [ 716.370750][ T27] do_exit+0xbd4/0x2a60 [ 716.375323][ T27] ? lock_acquire+0x442/0x510 [ 716.380007][ T27] ? rcu_read_lock_sched_held+0xd/0x70 [ 716.385913][ T27] ? lock_release+0x522/0x720 [ 716.390606][ T27] ? mm_update_next_owner+0x7a0/0x7a0 [ 716.396239][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.401106][ T27] ? do_raw_spin_lock+0x120/0x2b0 [ 716.406348][ T27] ? rwlock_bug.part.0+0x90/0x90 [ 716.411293][ T27] do_group_exit+0x125/0x310 [ 716.416414][ T27] get_signal+0x47f/0x2160 [ 716.420887][ T27] ? lock_downgrade+0x6e0/0x6e0 [ 716.425964][ T27] ? wake_up_q+0xf0/0xf0 [ 716.430269][ T27] arch_do_signal_or_restart+0x2a9/0x1c40 [ 716.436263][ T27] ? rfcomm_sock_connect+0x15f/0x460 [ 716.441556][ T27] ? rfcomm_sock_getname+0x300/0x300 [ 716.447295][ T27] ? __sys_connect_file+0x4e/0x1a0 [ 716.452592][ T27] ? get_sigframe_size+0x10/0x10 [ 716.457833][ T27] ? __sys_connect_file+0x1a0/0x1a0 [ 716.463051][ T27] exit_to_user_mode_prepare+0x17d/0x290 [ 716.468936][ T27] syscall_exit_to_user_mode+0x19/0x60 [ 716.474489][ T27] do_syscall_64+0x42/0xb0 [ 716.478933][ T27] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 716.484866][ T27] RIP: 0033:0x446009 [ 716.488753][ T27] RSP: 002b:00007ffc1aae5d68 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 716.497176][ T27] RAX: fffffffffffffffc RBX: 0000000000000003 RCX: 0000000000446009 [ 716.505182][ T27] RDX: 0000000000000080 RSI: 0000000020000000 RDI: 0000000000000004 [ 716.513145][ T27] RBP: 0000000000000003 R08: 000000ff00000001 R09: 000000ff00000001 [ 716.521139][ T27] R10: 0000000000000000 R11: 0000000000000246 R12: 00000000011df2b8 [ 716.529262][ T27] R13: 000000000000000e R14: 00007ffc1aae5dc0 R15: 0000000000000003 [ 716.537388][ T27] INFO: lockdep is turned off. [ 716.542141][ T27] NMI backtrace for cpu 0 [ 716.546457][ T27] CPU: 0 PID: 27 Comm: khungtaskd Not tainted 5.14.0-rc5-next-20210812-syzkaller #0 [ 716.555832][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 716.565985][ T27] Call Trace: [ 716.569286][ T27] dump_stack_lvl+0xcd/0x134 [ 716.573940][ T27] nmi_cpu_backtrace.cold+0x47/0x144 [ 716.579231][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 716.584455][ T27] nmi_trigger_cpumask_backtrace+0x1ae/0x220 [ 716.590469][ T27] watchdog+0xcb7/0xed0 [ 716.594619][ T27] ? trace_sched_process_hang+0x280/0x280 [ 716.600349][ T27] kthread+0x3e5/0x4d0 [ 716.604410][ T27] ? set_kthread_struct+0x130/0x130 [ 716.609597][ T27] ret_from_fork+0x1f/0x30 [ 716.614089][ T27] Sending NMI from CPU 0 to CPUs 1: [ 716.619728][ C1] NMI backtrace for cpu 1 [ 716.619737][ C1] CPU: 1 PID: 6599 Comm: kworker/u4:1 Not tainted 5.14.0-rc5-next-20210812-syzkaller #0 [ 716.619759][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 716.619771][ C1] Workqueue: events_unbound toggle_allocation_gate [ 716.619843][ C1] RIP: 0010:debug_object_activate+0x172/0x3e0 [ 716.619895][ C1] Code: 8b ab 40 1e 3c 90 31 db 48 85 ed 74 48 49 bd 00 00 00 00 00 fc ff df 48 8d 7d 18 83 c3 01 48 89 f8 48 c1 e8 03 42 80 3c 28 00 <0f> 85 c6 01 00 00 4c 3b 65 18 0f 84 bf 00 00 00 48 89 e8 48 c1 e8 [ 716.619914][ C1] RSP: 0018:ffffc900012ef9e0 EFLAGS: 00000046 [ 716.619929][ C1] RAX: 1ffff1100210b8ab RBX: 0000000000000003 RCX: ffffffff815b8c80 [ 716.619942][ C1] RDX: 1ffffffff20969cb RSI: 0000000000000006 RDI: ffff88801085c558 [ 716.619955][ C1] RBP: ffff88801085c540 R08: ffffffff904b4e48 R09: 0000000000000003 [ 716.619968][ C1] R10: fffff5200025df2a R11: 0000000000000000 R12: ffffffff8bac2508 [ 716.619981][ C1] R13: dffffc0000000000 R14: 1ffff9200025df3e R15: ffffffff898dcc40 [ 716.619994][ C1] FS: 0000000000000000(0000) GS:ffff8880b9d00000(0000) knlGS:0000000000000000 [ 716.620013][ C1] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 716.620026][ C1] CR2: 00007f0fcbe40010 CR3: 000000000b68e000 CR4: 00000000001506e0 [ 716.620039][ C1] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 [ 716.620050][ C1] DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 [ 716.620062][ C1] Call Trace: [ 716.620067][ C1] ? lock_release+0x720/0x720 [ 716.620088][ C1] ? debug_object_assert_init+0x2e0/0x2e0 [ 716.620111][ C1] ? rwlock_bug.part.0+0x90/0x90 [ 716.620134][ C1] __mod_timer+0x77d/0xe30 [ 716.620180][ C1] ? run_timer_softirq+0x1d0/0x1d0 [ 716.620204][ C1] ? __mutex_unlock_slowpath+0x157/0x5e0 [ 716.620231][ C1] ? rcu_read_lock_sched_held+0xd/0x70 [ 716.620256][ C1] ? lock_release+0x522/0x720 [ 716.620275][ C1] ? toggle_allocation_gate+0x185/0x390 [ 716.620299][ C1] __queue_delayed_work+0x1a7/0x270 [ 716.620324][ C1] queue_delayed_work_on+0x105/0x120 [ 716.620345][ C1] toggle_allocation_gate+0x1ca/0x390 [ 716.620366][ C1] ? lock_release+0x720/0x720 [ 716.620385][ C1] ? wake_up_kfence_timer+0x20/0x20 [ 716.620407][ C1] ? finish_wait+0x270/0x270 [ 716.620425][ C1] ? read_word_at_a_time+0xe/0x20 [ 716.620449][ C1] ? strscpy+0xa1/0x2b0 [ 716.620468][ C1] process_one_work+0x98d/0x1630 [ 716.620496][ C1] ? pwq_dec_nr_in_flight+0x320/0x320 [ 716.620522][ C1] ? rwlock_bug.part.0+0x90/0x90 [ 716.620546][ C1] worker_thread+0x658/0x11f0 [ 716.620573][ C1] ? process_one_work+0x1630/0x1630 [ 716.620598][ C1] kthread+0x3e5/0x4d0 [ 716.620619][ C1] ? _raw_spin_unlock_irq+0x1f/0x40 [ 716.620639][ C1] ? set_kthread_struct+0x130/0x130 [ 716.620662][ C1] ret_from_fork+0x1f/0x30 [ 716.621479][ T27] Kernel panic - not syncing: hung_task: blocked tasks [ 716.901686][ T27] CPU: 1 PID: 27 Comm: khungtaskd Not tainted 5.14.0-rc5-next-20210812-syzkaller #0 [ 716.911054][ T27] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 716.921085][ T27] Call Trace: [ 716.924347][ T27] dump_stack_lvl+0xcd/0x134 [ 716.928920][ T27] panic+0x2b0/0x6dd [ 716.932818][ T27] ? __warn_printk+0xf3/0xf3 [ 716.937387][ T27] ? lapic_can_unplug_cpu+0x80/0x80 [ 716.942570][ T27] ? preempt_schedule_thunk+0x16/0x18 [ 716.947925][ T27] ? nmi_trigger_cpumask_backtrace+0x191/0x220 [ 716.954066][ T27] ? watchdog.cold+0x1b9/0x1de [ 716.958848][ T27] watchdog.cold+0x1ca/0x1de [ 716.963434][ T27] ? trace_sched_process_hang+0x280/0x280 [ 716.969136][ T27] kthread+0x3e5/0x4d0 [ 716.973190][ T27] ? set_kthread_struct+0x130/0x130 [ 716.978382][ T27] ret_from_fork+0x1f/0x30 [ 716.984019][ T27] Kernel Offset: disabled [ 716.988332][ T27] Rebooting in 86400 seconds..