Warning: Permanently added '10.128.0.115' (ED25519) to the list of known hosts. 2024/03/15 13:05:52 ignoring optional flag "sandboxArg"="0" 2024/03/15 13:05:52 parsed 1 programs 2024/03/15 13:05:53 executed programs: 0 [ 42.996513][ T2250] Adding 124996k swap on ./swap-file. Priority:0 extents:1 across:124996k [ 45.569161][ C0] [ 45.571496][ C0] ======================================================== [ 45.579873][ C0] WARNING: possible irq lock inversion dependency detected [ 45.587148][ C0] 6.8.0-rc2-syzkaller #0 Not tainted [ 45.592418][ C0] -------------------------------------------------------- [ 45.599664][ C0] swapper/0/0 just changed the state of lock: [ 45.605699][ C0] ffff888103330110 (&group->lock){..-.}-{2:2}, at: snd_pcm_period_elapsed+0x1a/0xa0 [ 45.615144][ C0] but this lock took another, SOFTIRQ-unsafe lock in the past: [ 45.622673][ C0] (&timer->lock){+.+.}-{2:2} [ 45.622678][ C0] [ 45.622678][ C0] [ 45.622678][ C0] and interrupts could create inverse lock ordering between them. [ 45.622678][ C0] [ 45.641877][ C0] [ 45.641877][ C0] other info that might help us debug this: [ 45.650108][ C0] Possible interrupt unsafe locking scenario: [ 45.650108][ C0] [ 45.658418][ C0] CPU0 CPU1 [ 45.664102][ C0] ---- ---- [ 45.669607][ C0] lock(&timer->lock); [ 45.673846][ C0] local_irq_disable(); [ 45.680662][ C0] lock(&group->lock); [ 45.687492][ C0] lock(&timer->lock); [ 45.694679][ C0] [ 45.698189][ C0] lock(&group->lock); [ 45.702486][ C0] [ 45.702486][ C0] *** DEADLOCK *** [ 45.702486][ C0] [ 45.710607][ C0] no locks held by swapper/0/0. [ 45.715435][ C0] [ 45.715435][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 45.725733][ C0] -> (&timer->lock){+.+.}-{2:2} { [ 45.730816][ C0] HARDIRQ-ON-W at: [ 45.734846][ C0] lock_acquire+0xea/0x270 [ 45.741147][ C0] _raw_spin_lock+0x2e/0x40 [ 45.747650][ C0] snd_timer_close_locked+0x2a/0x290 [ 45.756557][ C0] snd_timer_close+0x40/0x80 [ 45.762936][ C0] snd_seq_timer_close+0x43/0x60 [ 45.769667][ C0] snd_seq_queue_delete+0xaf/0x120 [ 45.776660][ C0] snd_seq_oss_release+0x88/0xd0 [ 45.783839][ C0] odev_release+0x27/0x40 [ 45.790309][ C0] __fput+0xf4/0x290 [ 45.796062][ C0] __se_sys_close+0x6a/0xc0 [ 45.802625][ C0] do_syscall_64+0xa7/0x190 [ 45.809092][ C0] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 45.816862][ C0] SOFTIRQ-ON-W at: [ 45.821054][ C0] lock_acquire+0xea/0x270 [ 45.827441][ C0] _raw_spin_lock+0x2e/0x40 [ 45.834804][ C0] snd_timer_close_locked+0x2a/0x290 [ 45.841895][ C0] snd_timer_close+0x40/0x80 [ 45.848304][ C0] snd_seq_timer_close+0x43/0x60 [ 45.855127][ C0] snd_seq_queue_delete+0xaf/0x120 [ 45.862217][ C0] snd_seq_oss_release+0x88/0xd0 [ 45.869041][ C0] odev_release+0x27/0x40 [ 45.875429][ C0] __fput+0xf4/0x290 [ 45.881469][ C0] __se_sys_close+0x6a/0xc0 [ 45.887852][ C0] do_syscall_64+0xa7/0x190 [ 45.894242][ C0] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 45.901951][ C0] INITIAL USE at: [ 45.905915][ C0] lock_acquire+0xea/0x270 [ 45.912039][ C0] _raw_spin_lock_irqsave+0x61/0xa0 [ 45.919474][ C0] snd_timer_notify+0x5b/0x140 [ 45.926436][ C0] snd_pcm_post_stop+0x49/0x80 [ 45.932913][ C0] snd_pcm_action+0xcf/0x100 [ 45.939317][ C0] snd_pcm_drop+0x7b/0xd0 [ 45.945470][ C0] snd_pcm_oss_sync+0xb2/0x420 [ 45.951950][ C0] snd_pcm_oss_release+0x44/0xe0 [ 45.959118][ C0] __fput+0xf4/0x290 [ 45.965074][ C0] __se_sys_close+0x6a/0xc0 [ 45.971295][ C0] do_syscall_64+0xa7/0x190 [ 45.977503][ C0] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 45.985457][ C0] } [ 45.988104][ C0] ... key at: [] snd_timer_new.__key+0x0/0x10 [ 45.996400][ C0] ... acquired at: [ 46.000288][ C0] _raw_spin_lock_irqsave+0x61/0xa0 [ 46.005627][ C0] snd_timer_notify+0x5b/0x140 [ 46.010718][ C0] snd_pcm_post_stop+0x49/0x80 [ 46.016261][ C0] snd_pcm_action+0xcf/0x100 [ 46.021099][ C0] snd_pcm_drop+0x7b/0xd0 [ 46.025566][ C0] snd_pcm_oss_sync+0xb2/0x420 [ 46.030470][ C0] snd_pcm_oss_release+0x44/0xe0 [ 46.035908][ C0] __fput+0xf4/0x290 [ 46.040056][ C0] __se_sys_close+0x6a/0xc0 [ 46.044896][ C0] do_syscall_64+0xa7/0x190 [ 46.049717][ C0] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 46.056272][ C0] [ 46.058565][ C0] -> (&group->lock){..-.}-{2:2} { [ 46.063657][ C0] IN-SOFTIRQ-W at: [ 46.067802][ C0] lock_acquire+0xea/0x270 [ 46.074187][ C0] _raw_spin_lock_irqsave+0x61/0xa0 [ 46.081462][ C0] snd_pcm_period_elapsed+0x1a/0xa0 [ 46.088372][ C0] dummy_hrtimer_callback+0x1a/0x50 [ 46.095394][ C0] __hrtimer_run_queues+0x1a6/0x330 [ 46.102315][ C0] hrtimer_run_softirq+0xa4/0x180 [ 46.108967][ C0] __do_softirq+0x149/0x3d1 [ 46.115371][ C0] __irq_exit_rcu+0x6f/0x100 [ 46.121584][ C0] irq_exit_rcu+0x9/0x30 [ 46.127539][ C0] sysvec_apic_timer_interrupt+0x92/0xb0 [ 46.134978][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 46.143034][ C0] acpi_safe_halt+0x20/0x30 [ 46.149253][ C0] acpi_idle_enter+0xc1/0xe0 [ 46.156163][ C0] cpuidle_enter_state+0xff/0x260 [ 46.162899][ C0] cpuidle_enter+0x28/0x40 [ 46.170320][ C0] do_idle+0x1c8/0x270 [ 46.176148][ C0] cpu_startup_entry+0x24/0x30 [ 46.183605][ C0] rest_init+0x1e5/0x1f0 [ 46.189656][ C0] arch_call_rest_init+0x9/0x10 [ 46.196446][ C0] start_kernel+0x314/0x330 [ 46.202923][ C0] x86_64_start_reservations+0x2a/0x30 [ 46.210262][ C0] x86_64_start_kernel+0x94/0xa0 [ 46.217432][ C0] secondary_startup_64_no_verify+0x15f/0x16b [ 46.225140][ C0] INITIAL USE at: [ 46.229218][ C0] lock_acquire+0xea/0x270 [ 46.235381][ C0] _raw_spin_lock_irq+0x5c/0x90 [ 46.242568][ C0] snd_pcm_hw_params+0xa7/0x7a0 [ 46.249405][ C0] snd_pcm_oss_change_params_locked+0xbcc/0x1130 [ 46.257324][ C0] snd_pcm_oss_make_ready+0xac/0x110 [ 46.264148][ C0] snd_pcm_oss_sync+0x95/0x420 [ 46.270812][ C0] snd_pcm_oss_release+0x44/0xe0 [ 46.277838][ C0] __fput+0xf4/0x290 [ 46.283539][ C0] __se_sys_close+0x6a/0xc0 [ 46.289777][ C0] do_syscall_64+0xa7/0x190 [ 46.296187][ C0] entry_SYSCALL_64_after_hwframe+0x6f/0x77 [ 46.304067][ C0] } [ 46.306625][ C0] ... key at: [] snd_pcm_group_init.__key+0x0/0x10 [ 46.315451][ C0] ... acquired at: [ 46.319926][ C0] mark_lock+0xe9/0x150 [ 46.324411][ C0] __lock_acquire+0x4c5/0x2490 [ 46.330114][ C0] lock_acquire+0xea/0x270 [ 46.335342][ C0] _raw_spin_lock_irqsave+0x61/0xa0 [ 46.342567][ C0] snd_pcm_period_elapsed+0x1a/0xa0 [ 46.348468][ C0] dummy_hrtimer_callback+0x1a/0x50 [ 46.354609][ C0] __hrtimer_run_queues+0x1a6/0x330 [ 46.361035][ C0] hrtimer_run_softirq+0xa4/0x180 [ 46.366651][ C0] __do_softirq+0x149/0x3d1 [ 46.371594][ C0] __irq_exit_rcu+0x6f/0x100 [ 46.376336][ C0] irq_exit_rcu+0x9/0x30 [ 46.380728][ C0] sysvec_apic_timer_interrupt+0x92/0xb0 [ 46.386593][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 46.392725][ C0] acpi_safe_halt+0x20/0x30 [ 46.397728][ C0] acpi_idle_enter+0xc1/0xe0 [ 46.402563][ C0] cpuidle_enter_state+0xff/0x260 [ 46.407733][ C0] cpuidle_enter+0x28/0x40 [ 46.412475][ C0] do_idle+0x1c8/0x270 [ 46.416689][ C0] cpu_startup_entry+0x24/0x30 [ 46.421769][ C0] rest_init+0x1e5/0x1f0 [ 46.426158][ C0] arch_call_rest_init+0x9/0x10 [ 46.431178][ C0] start_kernel+0x314/0x330 [ 46.435870][ C0] x86_64_start_reservations+0x2a/0x30 [ 46.441567][ C0] x86_64_start_kernel+0x94/0xa0 [ 46.446824][ C0] secondary_startup_64_no_verify+0x15f/0x16b [ 46.453390][ C0] [ 46.455713][ C0] [ 46.455713][ C0] stack backtrace: [ 46.461769][ C0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 6.8.0-rc2-syzkaller #0 [ 46.469636][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/29/2024 [ 46.480123][ C0] Call Trace: [ 46.483488][ C0] [ 46.486327][ C0] dump_stack_lvl+0x8d/0xe0 [ 46.490810][ C0] print_irq_inversion_bug+0x2c1/0x2d0 [ 46.496361][ C0] mark_lock_irq+0x32b/0x500 [ 46.501175][ C0] mark_lock+0xe9/0x150 [ 46.505310][ C0] __lock_acquire+0x4c5/0x2490 [ 46.510216][ C0] ? __lock_acquire+0x4ef/0x2490 [ 46.515306][ C0] ? __lock_acquire+0x4ef/0x2490 [ 46.520325][ C0] ? snd_pcm_period_elapsed+0x1a/0xa0 [ 46.525779][ C0] lock_acquire+0xea/0x270 [ 46.530378][ C0] ? snd_pcm_period_elapsed+0x1a/0xa0 [ 46.536143][ C0] ? __pfx_dummy_hrtimer_callback+0x10/0x10 [ 46.542013][ C0] ? _raw_spin_lock_irqsave+0x3b/0xa0 [ 46.547716][ C0] ? __pfx_dummy_hrtimer_callback+0x10/0x10 [ 46.553754][ C0] _raw_spin_lock_irqsave+0x61/0xa0 [ 46.559005][ C0] ? snd_pcm_period_elapsed+0x1a/0xa0 [ 46.564517][ C0] snd_pcm_period_elapsed+0x1a/0xa0 [ 46.569685][ C0] dummy_hrtimer_callback+0x1a/0x50 [ 46.576680][ C0] __hrtimer_run_queues+0x1a6/0x330 [ 46.583506][ C0] hrtimer_run_softirq+0xa4/0x180 [ 46.589003][ C0] ? __do_softirq+0xc3/0x3d1 [ 46.594089][ C0] __do_softirq+0x149/0x3d1 [ 46.598936][ C0] ? __irq_exit_rcu+0x6f/0x100 [ 46.604008][ C0] ? hrtimer_interrupt+0x121/0x3a0 [ 46.609340][ C0] __irq_exit_rcu+0x6f/0x100 [ 46.614429][ C0] irq_exit_rcu+0x9/0x30 [ 46.618826][ C0] sysvec_apic_timer_interrupt+0x92/0xb0 [ 46.624539][ C0] [ 46.627462][ C0] [ 46.630464][ C0] asm_sysvec_apic_timer_interrupt+0x1a/0x20 [ 46.636604][ C0] RIP: 0010:acpi_safe_halt+0x20/0x30 [ 46.642076][ C0] Code: 90 90 90 90 90 90 90 90 90 90 65 48 8b 05 18 a8 95 7d 48 f7 00 08 00 00 00 75 10 66 90 0f 00 2d 00 86 46 00 f3 0f 1e fa fb f4 c3 cc cc cc cc 66 2e 0f 1f 84 00 00 00 00 00 90 90 90 90 90 90 [ 46.662872][ C0] RSP: 0018:ffffffff83403e00 EFLAGS: 00000246 [ 46.668995][ C0] RAX: ffffffff83423780 RBX: ffff8881016fdc64 RCX: ffff88813bc00000 [ 46.677218][ C0] RDX: 0000000000000001 RSI: ffff8881016fdc00 RDI: ffff8881016fdc64 [ 46.685652][ C0] RBP: ffff888100ae0000 R08: 0000000af1184887 R09: 00000000000000ff [ 46.693614][ C0] R10: 0000000000000003 R11: ffffffff826d2710 R12: 0000000000000001 [ 46.701646][ C0] R13: 0000000000000000 R14: 0000000000000001 R15: ffffffff83643cb0 [ 46.710062][ C0] ? __pfx_acpi_idle_enter+0x10/0x10 [ 46.715439][ C0] acpi_idle_enter+0xc1/0xe0 [ 46.720002][ C0] cpuidle_enter_state+0xff/0x260 [ 46.724996][ C0] cpuidle_enter+0x28/0x40 [ 46.729491][ C0] do_idle+0x1c8/0x270 [ 46.733526][ C0] cpu_startup_entry+0x24/0x30 [ 46.738356][ C0] ? rest_init+0x2c/0x1f0 [ 46.742663][ C0] rest_init+0x1e5/0x1f0 [ 46.747059][ C0] arch_call_rest_init+0x9/0x10 [ 46.751911][ C0] start_kernel+0x314/0x330 [ 46.756429][ C0] x86_64_start_reservations+0x2a/0x30 [ 46.762121][ C0] x86_64_start_kernel+0x94/0xa0 [ 46.767462][ C0] secondary_startup_64_no_verify+0x15f/0x16b [ 46.774135][ C0] 2024/03/15 13:05:58 executed programs: 4 2024/03/15 13:06:03 executed programs: 14