[ 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.0.43' (ECDSA) to the list of known hosts. executing program executing program executing program executing program executing program executing program syzkaller login: [ 72.901487][ C1] [ 72.903836][ C1] ======================================================== [ 72.911004][ C1] WARNING: possible irq lock inversion dependency detected [ 72.918174][ C1] 5.9.0-rc5-next-20200918-syzkaller #0 Not tainted [ 72.924646][ C1] -------------------------------------------------------- [ 72.931817][ C1] swapper/1/0 just changed the state of lock: [ 72.937853][ C1] ffff8880a78bd908 (&group->lock){..-.}-{2:2}, at: _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 72.947735][ C1] but this lock took another, SOFTIRQ-READ-unsafe lock in the past: [ 72.955729][ C1] (&card->ctl_files_rwlock){.+.+}-{2:2} [ 72.955754][ C1] [ 72.955754][ C1] [ 72.955754][ C1] and interrupts could create inverse lock ordering between them. [ 72.955754][ C1] [ 72.975651][ C1] [ 72.975651][ C1] other info that might help us debug this: [ 72.983683][ C1] Possible interrupt unsafe locking scenario: [ 72.983683][ C1] [ 72.991974][ C1] CPU0 CPU1 [ 72.997314][ C1] ---- ---- [ 73.002680][ C1] lock(&card->ctl_files_rwlock); [ 73.007789][ C1] local_irq_disable(); [ 73.014518][ C1] lock(&group->lock); [ 73.021186][ C1] lock(&card->ctl_files_rwlock); [ 73.028809][ C1] [ 73.032246][ C1] lock(&group->lock); [ 73.036567][ C1] [ 73.036567][ C1] *** DEADLOCK *** [ 73.036567][ C1] [ 73.044690][ C1] 1 lock held by swapper/1/0: [ 73.049422][ C1] #0: ffffc90000da8d80 ((&dpcm->timer)){+.-.}-{0:0}, at: call_timer_fn+0xd5/0x6b0 [ 73.058713][ C1] [ 73.058713][ C1] the shortest dependencies between 2nd lock and 1st lock: [ 73.068079][ C1] -> (&card->ctl_files_rwlock){.+.+}-{2:2} { [ 73.074131][ C1] HARDIRQ-ON-R at: [ 73.078192][ C1] lock_acquire+0x1f2/0xaa0 [ 73.084523][ C1] _raw_read_lock+0x5b/0x70 [ 73.090828][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 73.097850][ C1] snd_ctl_notify+0x8f/0xb0 [ 73.104152][ C1] __snd_ctl_add_replace+0x638/0x800 [ 73.111236][ C1] snd_ctl_add_replace+0x76/0x130 [ 73.118075][ C1] snd_dummy_probe+0xc22/0x1180 [ 73.124747][ C1] platform_drv_probe+0x87/0x140 [ 73.131496][ C1] really_probe+0x282/0x9f0 [ 73.137810][ C1] driver_probe_device+0xfe/0x1d0 [ 73.144631][ C1] __device_attach_driver+0x1c2/0x220 [ 73.151802][ C1] bus_for_each_drv+0x15f/0x1e0 [ 73.158452][ C1] __device_attach+0x228/0x470 [ 73.165015][ C1] bus_probe_device+0x1e4/0x290 [ 73.171665][ C1] device_add+0xb17/0x1c40 [ 73.177881][ C1] platform_device_add+0x34f/0x6d0 [ 73.184899][ C1] platform_device_register_full+0x38c/0x4e0 [ 73.192679][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 73.199693][ C1] do_one_initcall+0x103/0x6f0 [ 73.206255][ C1] kernel_init_freeable+0x652/0x6d6 [ 73.213259][ C1] kernel_init+0xd/0x1b8 [ 73.219317][ C1] ret_from_fork+0x1f/0x30 [ 73.225527][ C1] SOFTIRQ-ON-R at: [ 73.229579][ C1] lock_acquire+0x1f2/0xaa0 [ 73.235947][ C1] _raw_read_lock+0x5b/0x70 [ 73.242284][ C1] snd_ctl_notify.part.0+0x36/0x550 [ 73.249301][ C1] snd_ctl_notify+0x8f/0xb0 [ 73.255618][ C1] __snd_ctl_add_replace+0x638/0x800 [ 73.262701][ C1] snd_ctl_add_replace+0x76/0x130 [ 73.269542][ C1] snd_dummy_probe+0xc22/0x1180 [ 73.276214][ C1] platform_drv_probe+0x87/0x140 [ 73.282948][ C1] really_probe+0x282/0x9f0 [ 73.289251][ C1] driver_probe_device+0xfe/0x1d0 [ 73.296072][ C1] __device_attach_driver+0x1c2/0x220 [ 73.303261][ C1] bus_for_each_drv+0x15f/0x1e0 [ 73.309909][ C1] __device_attach+0x228/0x470 [ 73.316470][ C1] bus_probe_device+0x1e4/0x290 [ 73.323119][ C1] device_add+0xb17/0x1c40 [ 73.329337][ C1] platform_device_add+0x34f/0x6d0 [ 73.336248][ C1] platform_device_register_full+0x38c/0x4e0 [ 73.344040][ C1] alsa_card_dummy_init+0x1e0/0x309 [ 73.351040][ C1] do_one_initcall+0x103/0x6f0 [ 73.357613][ C1] kernel_init_freeable+0x652/0x6d6 [ 73.364609][ C1] kernel_init+0xd/0x1b8 [ 73.370649][ C1] ret_from_fork+0x1f/0x30 [ 73.376857][ C1] (null) at: [ 73.380380][ C1] ================================================================================ [ 73.389643][ C1] UBSAN: array-index-out-of-bounds in kernel/locking/lockdep.c:2240:40 [ 73.397852][ C1] index 9 is out of range for type 'lock_trace *[9]' [ 73.404509][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 73.413605][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 73.423635][ C1] Call Trace: [ 73.426915][ C1] [ 73.429774][ C1] dump_stack+0x198/0x1fb [ 73.434083][ C1] ubsan_epilogue+0xb/0x5a [ 73.438476][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 73.444627][ C1] ? vprintk_func+0x95/0x1e0 [ 73.449219][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 73.455999][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 73.462047][ C1] mark_lock.cold+0x57/0x74 [ 73.466530][ C1] ? lock_chain_count+0x20/0x20 [ 73.471360][ C1] ? lock_is_held_type+0xbb/0xf0 [ 73.476283][ C1] ? find_held_lock+0x2d/0x110 [ 73.481028][ C1] ? debug_object_activate+0x287/0x3e0 [ 73.486489][ C1] ? lock_downgrade+0x830/0x830 [ 73.491317][ C1] __lock_acquire+0x118a/0x56d0 [ 73.496145][ C1] ? lock_downgrade+0x830/0x830 [ 73.500971][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 73.506941][ C1] ? mark_lock+0xf7/0x2420 [ 73.511338][ C1] lock_acquire+0x1f2/0xaa0 [ 73.515820][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 73.521701][ C1] ? lock_release+0x890/0x890 [ 73.526360][ C1] ? find_held_lock+0x2d/0x110 [ 73.531107][ C1] ? loopback_jiffies_timer_function+0x188/0x220 [ 73.537413][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 73.542761][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 73.547993][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 73.553866][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 73.559564][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 73.564841][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 73.570990][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 73.577468][ C1] call_timer_fn+0x1a5/0x6b0 [ 73.582037][ C1] ? add_timer_on+0x4a0/0x4a0 [ 73.586694][ C1] ? lock_downgrade+0x830/0x830 [ 73.591630][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 73.596808][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 73.603285][ C1] __run_timers.part.0+0x67c/0xa50 [ 73.608373][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 73.613129][ C1] ? lapic_next_event+0x4d/0x80 [ 73.617960][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 73.623135][ C1] ? sched_clock+0x2a/0x40 [ 73.627526][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 73.632354][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 73.637465][ C1] run_timer_softirq+0xb3/0x1d0 [ 73.642298][ C1] __do_softirq+0x203/0xab6 [ 73.646800][ C1] asm_call_on_stack+0xf/0x20 [ 73.651456][ C1] [ 73.654389][ C1] do_softirq_own_stack+0x9d/0xd0 [ 73.659413][ C1] irq_exit_rcu+0x235/0x280 [ 73.663935][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 73.669562][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 73.675531][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 73.680877][ C1] Code: 89 ef e8 a5 99 76 f9 e9 86 fe ff ff 48 89 df e8 98 99 76 f9 e9 7b ff ff ff cc cc cc e9 07 00 00 00 0f 00 2d c4 14 49 00 fb f4 90 e9 07 00 00 00 0f 00 2d b4 14 49 00 f4 c3 cc cc 55 53 e8 09 [ 73.700482][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 73.706529][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 73.714484][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 73.722454][ C1] RBP: ffff88821a8b3064 R08: 0000000000000001 R09: 0000000000000001 [ 73.730412][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 73.738376][ C1] R13: ffff88821a8b3000 R14: ffff88821a8b3064 R15: ffff8880a2cbf804 [ 73.746337][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 73.751603][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 73.756605][ C1] acpi_idle_enter+0x35a/0x550 [ 73.761400][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 73.766507][ C1] cpuidle_enter+0x4a/0xa0 [ 73.770904][ C1] do_idle+0x48e/0x730 [ 73.774953][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 73.779968][ C1] cpu_startup_entry+0x14/0x20 [ 73.784711][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 73.790601][ C1] ================================================================================ [ 73.799854][ C1] Kernel panic - not syncing: panic_on_warn set ... [ 73.806421][ C1] CPU: 1 PID: 0 Comm: swapper/1 Not tainted 5.9.0-rc5-next-20200918-syzkaller #0 [ 73.815499][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 73.825529][ C1] Call Trace: [ 73.828792][ C1] [ 73.831636][ C1] dump_stack+0x198/0x1fb [ 73.835955][ C1] panic+0x382/0x7fb [ 73.839913][ C1] ? __warn_printk+0xf3/0xf3 [ 73.844483][ C1] ? secondary_startup_64_no_verify+0xa6/0xab [ 73.850540][ C1] ? ubsan_epilogue+0x3e/0x5a [ 73.855288][ C1] ? ubsan_epilogue+0x35/0x5a [ 73.859941][ C1] ubsan_epilogue+0x54/0x5a [ 73.864421][ C1] __ubsan_handle_out_of_bounds.cold+0x62/0x6c [ 73.870899][ C1] ? vprintk_func+0x95/0x1e0 [ 73.875471][ C1] print_shortest_lock_dependencies.cold+0x11c/0x2e2 [ 73.882124][ C1] print_irq_inversion_bug.part.0+0x2c6/0x2ee [ 73.888187][ C1] mark_lock.cold+0x57/0x74 [ 73.892680][ C1] ? lock_chain_count+0x20/0x20 [ 73.897538][ C1] ? lock_is_held_type+0xbb/0xf0 [ 73.902451][ C1] ? find_held_lock+0x2d/0x110 [ 73.907210][ C1] ? debug_object_activate+0x287/0x3e0 [ 73.912679][ C1] ? lock_downgrade+0x830/0x830 [ 73.917521][ C1] __lock_acquire+0x118a/0x56d0 [ 73.922362][ C1] ? lock_downgrade+0x830/0x830 [ 73.927209][ C1] ? lockdep_hardirqs_on_prepare+0x530/0x530 [ 73.933180][ C1] ? mark_lock+0xf7/0x2420 [ 73.937585][ C1] lock_acquire+0x1f2/0xaa0 [ 73.942065][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 73.947937][ C1] ? lock_release+0x890/0x890 [ 73.952589][ C1] ? find_held_lock+0x2d/0x110 [ 73.957331][ C1] ? loopback_jiffies_timer_function+0x188/0x220 [ 73.963635][ C1] ? _raw_spin_lock_irqsave+0xa9/0xd0 [ 73.968997][ C1] _raw_spin_lock_irqsave+0x94/0xd0 [ 73.974183][ C1] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 73.980072][ C1] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 73.985784][ C1] snd_pcm_period_elapsed+0x24/0x250 [ 73.991064][ C1] loopback_jiffies_timer_function+0x1a8/0x220 [ 73.997356][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 74.003835][ C1] call_timer_fn+0x1a5/0x6b0 [ 74.008416][ C1] ? add_timer_on+0x4a0/0x4a0 [ 74.013070][ C1] ? lock_downgrade+0x830/0x830 [ 74.017904][ C1] ? _raw_spin_unlock_irq+0x1f/0x80 [ 74.023085][ C1] ? loopback_jiffies_timer_pos_update+0xf60/0xf60 [ 74.029575][ C1] __run_timers.part.0+0x67c/0xa50 [ 74.034689][ C1] ? call_timer_fn+0x6b0/0x6b0 [ 74.039484][ C1] ? lapic_next_event+0x4d/0x80 [ 74.044332][ C1] ? kvm_sched_clock_read+0x14/0x40 [ 74.049516][ C1] ? sched_clock+0x2a/0x40 [ 74.053930][ C1] ? sched_clock_cpu+0x18/0x1f0 [ 74.058768][ C1] ? hrtimer_interrupt+0x6f4/0x940 [ 74.063856][ C1] run_timer_softirq+0xb3/0x1d0 [ 74.068707][ C1] __do_softirq+0x203/0xab6 [ 74.073190][ C1] asm_call_on_stack+0xf/0x20 [ 74.077857][ C1] [ 74.080873][ C1] do_softirq_own_stack+0x9d/0xd0 [ 74.085876][ C1] irq_exit_rcu+0x235/0x280 [ 74.090373][ C1] sysvec_apic_timer_interrupt+0x51/0xf0 [ 74.095983][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 74.101939][ C1] RIP: 0010:native_safe_halt+0xe/0x10 [ 74.107287][ C1] Code: 89 ef e8 a5 99 76 f9 e9 86 fe ff ff 48 89 df e8 98 99 76 f9 e9 7b ff ff ff cc cc cc e9 07 00 00 00 0f 00 2d c4 14 49 00 fb f4 90 e9 07 00 00 00 0f 00 2d b4 14 49 00 f4 c3 cc cc 55 53 e8 09 [ 74.126878][ C1] RSP: 0018:ffffc90000d3fd80 EFLAGS: 00000293 [ 74.132925][ C1] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 1ffffffff171e639 [ 74.140889][ C1] RDX: ffff8880a961a340 RSI: ffffffff883fd4d3 RDI: 0000000000000000 [ 74.148839][ C1] RBP: ffff88821a8b3064 R08: 0000000000000001 R09: 0000000000000001 [ 74.156790][ C1] R10: 0000000000000000 R11: 0000000000000001 R12: 0000000000000001 [ 74.164766][ C1] R13: ffff88821a8b3000 R14: ffff88821a8b3064 R15: ffff8880a2cbf804 [ 74.172731][ C1] ? acpi_idle_do_entry+0x1e3/0x330 [ 74.177921][ C1] acpi_idle_do_entry+0x1e8/0x330 [ 74.182940][ C1] acpi_idle_enter+0x35a/0x550 [ 74.187699][ C1] cpuidle_enter_state+0x1ab/0xd20 [ 74.192787][ C1] cpuidle_enter+0x4a/0xa0 [ 74.197186][ C1] do_idle+0x48e/0x730 [ 74.201243][ C1] ? arch_cpu_idle_exit+0x70/0x70 [ 74.206245][ C1] cpu_startup_entry+0x14/0x20 [ 74.210996][ C1] secondary_startup_64_no_verify+0xa6/0xab [ 74.218128][ C1] Kernel Offset: disabled [ 74.222444][ C1] Rebooting in 86400 seconds..