Warning: Permanently added '10.128.1.13' (ECDSA) to the list of known hosts. 2021/12/20 02:20:11 parsed 1 programs syzkaller login: [ 53.995280][ T3604] cgroup: Unknown subsys name 'net' [ 54.142181][ T3604] cgroup: Unknown subsys name 'rlimit' 2021/12/20 02:20:11 executed programs: 0 [ 55.431116][ T3610] chnl_net:caif_netlink_parms(): no params data found [ 55.472869][ T3610] bridge0: port 1(bridge_slave_0) entered blocking state [ 55.480395][ T3610] bridge0: port 1(bridge_slave_0) entered disabled state [ 55.488359][ T3610] device bridge_slave_0 entered promiscuous mode [ 55.497292][ T3610] bridge0: port 2(bridge_slave_1) entered blocking state [ 55.504369][ T3610] bridge0: port 2(bridge_slave_1) entered disabled state [ 55.512914][ T3610] device bridge_slave_1 entered promiscuous mode [ 55.532811][ T3610] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 55.543635][ T3610] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 55.565045][ T3610] team0: Port device team_slave_0 added [ 55.572198][ T3610] team0: Port device team_slave_1 added [ 55.589400][ T3610] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 55.596428][ T3610] batman_adv: batadv0: The MTU of interface batadv_slave_0 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 55.622320][ T3610] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 55.634977][ T3610] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 55.641966][ T3610] batman_adv: batadv0: The MTU of interface batadv_slave_1 is too small (1500) to handle the transport of batman-adv packets. Packets going over this interface will be fragmented on layer2 which could impact the performance. Setting the MTU to 1560 would solve the problem. [ 55.668150][ T3610] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 55.692903][ T3610] device hsr_slave_0 entered promiscuous mode [ 55.700118][ T3610] device hsr_slave_1 entered promiscuous mode [ 55.777122][ T3610] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 55.788616][ T3610] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 55.797389][ T3610] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 55.807036][ T3610] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 55.827254][ T3610] bridge0: port 2(bridge_slave_1) entered blocking state [ 55.834469][ T3610] bridge0: port 2(bridge_slave_1) entered forwarding state [ 55.842315][ T3610] bridge0: port 1(bridge_slave_0) entered blocking state [ 55.849542][ T3610] bridge0: port 1(bridge_slave_0) entered forwarding state [ 55.892401][ T3610] 8021q: adding VLAN 0 to HW filter on device bond0 [ 55.903762][ T39] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 55.914933][ T39] bridge0: port 1(bridge_slave_0) entered disabled state [ 55.923432][ T39] bridge0: port 2(bridge_slave_1) entered disabled state [ 55.932120][ T39] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 55.944578][ T3610] 8021q: adding VLAN 0 to HW filter on device team0 [ 55.956292][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 55.964766][ T7] bridge0: port 1(bridge_slave_0) entered blocking state [ 55.971869][ T7] bridge0: port 1(bridge_slave_0) entered forwarding state [ 55.989097][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 55.997531][ T7] bridge0: port 2(bridge_slave_1) entered blocking state [ 56.004556][ T7] bridge0: port 2(bridge_slave_1) entered forwarding state [ 56.019938][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 56.028772][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 56.037361][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 56.049957][ T3620] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 56.061637][ T3610] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 56.073176][ T3610] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 56.081341][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 56.100978][ T3610] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 56.108933][ T3620] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 56.116575][ T3620] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 56.133624][ T39] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 56.152950][ T3610] device veth0_vlan entered promiscuous mode [ 56.160294][ T3620] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 56.168760][ T3620] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 56.176779][ T3620] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 56.189554][ T3610] device veth1_vlan entered promiscuous mode [ 56.208829][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 56.216925][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 56.224895][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 56.234800][ T3610] device veth0_macvtap entered promiscuous mode [ 56.244939][ T3610] device veth1_macvtap entered promiscuous mode [ 56.260230][ T3610] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 56.268317][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 56.278050][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 56.290012][ T3610] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 56.297805][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 56.309041][ T3610] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.318012][ T3610] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.327621][ T3610] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.336392][ T3610] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.393262][ T10] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 56.407367][ T10] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 56.421666][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 56.439754][ T10] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 56.448831][ T10] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 56.457996][ T3618] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 57.031869][ C0] [ 57.034219][ C0] ======================================================== [ 57.041384][ C0] WARNING: possible irq lock inversion dependency detected [ 57.048552][ C0] 5.16.0-rc5-syzkaller #0 Not tainted [ 57.053911][ C0] -------------------------------------------------------- [ 57.061074][ C0] swapper/0/0 just changed the state of lock: [ 57.067115][ C0] ffff8880226f5910 (&group->lock){..-.}-{2:2}, at: _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 57.077022][ C0] but this lock took another, SOFTIRQ-READ-unsafe lock in the past: [ 57.085199][ C0] (tasklist_lock){.+.+}-{2:2} [ 57.085218][ C0] [ 57.085218][ C0] [ 57.085218][ C0] and interrupts could create inverse lock ordering between them. [ 57.085218][ C0] [ 57.104230][ C0] [ 57.104230][ C0] other info that might help us debug this: [ 57.112264][ C0] Chain exists of: [ 57.112264][ C0] &group->lock --> &timer->lock --> tasklist_lock [ 57.112264][ C0] [ 57.124770][ C0] Possible interrupt unsafe locking scenario: [ 57.124770][ C0] [ 57.133339][ C0] CPU0 CPU1 [ 57.138683][ C0] ---- ---- [ 57.144026][ C0] lock(tasklist_lock); [ 57.148248][ C0] local_irq_disable(); [ 57.154977][ C0] lock(&group->lock); [ 57.161627][ C0] lock(&timer->lock); [ 57.168277][ C0] [ 57.171708][ C0] lock(&group->lock); [ 57.176013][ C0] [ 57.176013][ C0] *** DEADLOCK *** [ 57.176013][ C0] [ 57.184132][ C0] no locks held by swapper/0/0. [ 57.188957][ C0] [ 57.188957][ C0] the shortest dependencies between 2nd lock and 1st lock: [ 57.198308][ C0] -> (tasklist_lock){.+.+}-{2:2} { [ 57.203753][ C0] HARDIRQ-ON-R at: [ 57.208055][ C0] lock_acquire+0x1ab/0x510 [ 57.214888][ C0] _raw_read_lock+0x5b/0x70 [ 57.221727][ C0] do_wait+0x284/0xce0 [ 57.228132][ C0] kernel_wait+0x9c/0x150 [ 57.234787][ C0] call_usermodehelper_exec_work+0xf5/0x180 [ 57.243008][ C0] process_one_work+0x9b2/0x1690 [ 57.250272][ C0] worker_thread+0x658/0x11f0 [ 57.257271][ C0] kthread+0x405/0x4f0 [ 57.263673][ C0] ret_from_fork+0x1f/0x30 [ 57.270419][ C0] SOFTIRQ-ON-R at: [ 57.274848][ C0] lock_acquire+0x1ab/0x510 [ 57.281702][ C0] _raw_read_lock+0x5b/0x70 [ 57.288535][ C0] do_wait+0x284/0xce0 [ 57.294932][ C0] kernel_wait+0x9c/0x150 [ 57.301590][ C0] call_usermodehelper_exec_work+0xf5/0x180 [ 57.309814][ C0] process_one_work+0x9b2/0x1690 [ 57.317086][ C0] worker_thread+0x658/0x11f0 [ 57.324287][ C0] kthread+0x405/0x4f0 [ 57.330690][ C0] ret_from_fork+0x1f/0x30 [ 57.337459][ C0] INITIAL USE at: [ 57.341679][ C0] lock_acquire+0x1ab/0x510 [ 57.345245][ T25] audit: type=1804 audit(1639966814.739:2): pid=3623 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=invalid_pcr cause=ToMToU comm="syz-executor.0" name="/root/syzkaller-testdir023325272/syzkaller.e4y0N5/0/file0" dev="sda1" ino=1147 res=1 errno=0 [ 57.348426][ C0] _raw_write_lock_irq+0x32/0x50 [ 57.379903][ C0] copy_process+0x36c8/0x75a0 [ 57.386852][ C0] kernel_clone+0xe7/0xab0 [ 57.393537][ C0] kernel_thread+0xb5/0xf0 [ 57.400218][ C0] rest_init+0x23/0x3e0 [ 57.406637][ C0] start_kernel+0x47a/0x49b [ 57.413401][ C0] secondary_startup_64_no_verify+0xb0/0xbb [ 57.421563][ C0] INITIAL READ USE at: [ 57.426236][ C0] lock_acquire+0x1ab/0x510 [ 57.433534][ C0] _raw_read_lock+0x5b/0x70 [ 57.440735][ C0] do_wait+0x284/0xce0 [ 57.447499][ C0] kernel_wait+0x9c/0x150 [ 57.454711][ C0] call_usermodehelper_exec_work+0xf5/0x180 [ 57.463306][ C0] process_one_work+0x9b2/0x1690 [ 57.471022][ C0] worker_thread+0x658/0x11f0 [ 57.478392][ C0] kthread+0x405/0x4f0 [ 57.485158][ C0] ret_from_fork+0x1f/0x30 [ 57.492274][ C0] } [ 57.495112][ C0] ... key at: [] tasklist_lock+0x18/0x40 [ 57.503187][ C0] ... acquired at: [ 57.507332][ C0] _raw_read_lock+0x5b/0x70 [ 57.512015][ C0] send_sigio+0xab/0x380 [ 57.516436][ C0] kill_fasync+0x1f8/0x470 [ 57.521040][ C0] lease_break_callback+0x1f/0x30 [ 57.526239][ C0] __break_lease+0x3d7/0x1420 [ 57.531093][ C0] do_dentry_open+0x453/0x1250 [ 57.536032][ C0] path_openat+0x1cad/0x2750 [ 57.540800][ C0] do_filp_open+0x1aa/0x400 [ 57.545483][ C0] do_sys_openat2+0x16d/0x4d0 [ 57.550341][ C0] __x64_sys_creat+0xc9/0x120 [ 57.555196][ C0] do_syscall_64+0x35/0xb0 [ 57.559794][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 57.565872][ C0] [ 57.568186][ C0] -> (&f->f_owner.lock){....}-{2:2} { [ 57.573839][ C0] INITIAL USE at: [ 57.578019][ C0] lock_acquire+0x1ab/0x510 [ 57.584615][ C0] _raw_write_lock_irq+0x32/0x50 [ 57.591643][ C0] f_modown+0x2a/0x390 [ 57.597801][ C0] do_fcntl+0xb24/0x1210 [ 57.604223][ C0] __x64_sys_fcntl+0x165/0x1e0 [ 57.611076][ C0] do_syscall_64+0x35/0xb0 [ 57.617591][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 57.625579][ C0] INITIAL READ USE at: [ 57.630163][ C0] lock_acquire+0x1ab/0x510 [ 57.637189][ C0] _raw_read_lock_irqsave+0x70/0x90 [ 57.645001][ C0] send_sigio+0x24/0x380 [ 57.651767][ C0] kill_fasync+0x1f8/0x470 [ 57.658705][ C0] snd_timer_user_ccallback+0x298/0x330 [ 57.666776][ C0] snd_timer_notify1+0x11c/0x3b0 [ 57.674240][ C0] snd_timer_start1+0x4d4/0x800 [ 57.681613][ C0] snd_timer_user_start.isra.0+0x1e3/0x260 [ 57.689946][ C0] __snd_timer_user_ioctl.isra.0+0xda8/0x2490 [ 57.698543][ C0] snd_timer_user_ioctl+0x77/0xb0 [ 57.706097][ C0] __x64_sys_ioctl+0x193/0x200 [ 57.713390][ C0] do_syscall_64+0x35/0xb0 [ 57.720335][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 57.728757][ C0] } [ 57.731507][ C0] ... key at: [] __key.5+0x0/0x40 [ 57.738895][ C0] ... acquired at: [ 57.742949][ C0] _raw_read_lock_irqsave+0x70/0x90 [ 57.748327][ C0] send_sigio+0x24/0x380 [ 57.752751][ C0] kill_fasync+0x1f8/0x470 [ 57.757349][ C0] snd_timer_user_ccallback+0x298/0x330 [ 57.763078][ C0] snd_timer_notify1+0x11c/0x3b0 [ 57.768197][ C0] snd_timer_start1+0x4d4/0x800 [ 57.773224][ C0] snd_timer_user_start.isra.0+0x1e3/0x260 [ 57.779212][ C0] __snd_timer_user_ioctl.isra.0+0xda8/0x2490 [ 57.785459][ C0] snd_timer_user_ioctl+0x77/0xb0 [ 57.790663][ C0] __x64_sys_ioctl+0x193/0x200 [ 57.795606][ C0] do_syscall_64+0x35/0xb0 [ 57.800207][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 57.806279][ C0] [ 57.808595][ C0] -> (&new->fa_lock){....}-{2:2} { [ 57.813901][ C0] INITIAL READ USE at: [ 57.818403][ C0] lock_acquire+0x1ab/0x510 [ 57.825256][ C0] _raw_read_lock_irqsave+0x70/0x90 [ 57.832811][ C0] kill_fasync+0x136/0x470 [ 57.839581][ C0] snd_timer_user_ccallback+0x298/0x330 [ 57.847486][ C0] snd_timer_notify1+0x11c/0x3b0 [ 57.854778][ C0] snd_timer_start1+0x4d4/0x800 [ 57.861980][ C0] snd_timer_user_start.isra.0+0x1e3/0x260 [ 57.870143][ C0] __snd_timer_user_ioctl.isra.0+0xda8/0x2490 [ 57.878565][ C0] snd_timer_user_ioctl+0x77/0xb0 [ 57.885939][ C0] __x64_sys_ioctl+0x193/0x200 [ 57.893057][ C0] do_syscall_64+0x35/0xb0 [ 57.899827][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 57.908071][ C0] } [ 57.910734][ C0] ... key at: [] __key.0+0x0/0x40 [ 57.918020][ C0] ... acquired at: [ 57.922011][ C0] _raw_read_lock_irqsave+0x70/0x90 [ 57.927387][ C0] kill_fasync+0x136/0x470 [ 57.931983][ C0] snd_timer_user_ccallback+0x298/0x330 [ 57.937797][ C0] snd_timer_notify1+0x11c/0x3b0 [ 57.942917][ C0] snd_timer_start1+0x4d4/0x800 [ 57.947950][ C0] snd_timer_user_start.isra.0+0x1e3/0x260 [ 57.953937][ C0] __snd_timer_user_ioctl.isra.0+0xda8/0x2490 [ 57.960184][ C0] snd_timer_user_ioctl+0x77/0xb0 [ 57.965388][ C0] __x64_sys_ioctl+0x193/0x200 [ 57.970334][ C0] do_syscall_64+0x35/0xb0 [ 57.974932][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 57.981005][ C0] [ 57.983321][ C0] -> (&timer->lock){....}-{2:2} { [ 57.988455][ C0] INITIAL USE at: [ 57.992428][ C0] lock_acquire+0x1ab/0x510 [ 57.998675][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 58.005614][ C0] snd_timer_resolution+0x55/0x100 [ 58.012465][ C0] snd_timer_user_params.isra.0+0x18e/0x8c0 [ 58.020100][ C0] __snd_timer_user_ioctl.isra.0+0x1020/0x2490 [ 58.028010][ C0] snd_timer_user_ioctl+0x77/0xb0 [ 58.034782][ C0] __x64_sys_ioctl+0x193/0x200 [ 58.041293][ C0] do_syscall_64+0x35/0xb0 [ 58.047452][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 58.055086][ C0] } [ 58.057664][ C0] ... key at: [] __key.12+0x0/0x40 [ 58.064953][ C0] ... acquired at: [ 58.068835][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 58.074214][ C0] snd_timer_notify+0x10c/0x3d0 [ 58.079243][ C0] snd_pcm_post_start+0x24a/0x310 [ 58.084441][ C0] snd_pcm_action+0x143/0x170 [ 58.089289][ C0] __snd_pcm_lib_xfer+0x1289/0x1d80 [ 58.094663][ C0] snd_pcm_oss_write3+0x103/0x250 [ 58.099861][ C0] io_playback_transfer+0x27e/0x330 [ 58.105239][ C0] snd_pcm_plug_write_transfer+0x2cd/0x3f0 [ 58.111233][ C0] snd_pcm_oss_write2+0x245/0x3f0 [ 58.116453][ C0] snd_pcm_oss_write+0x75f/0x9c0 [ 58.121573][ C0] vfs_write+0x28e/0xae0 [ 58.126000][ C0] ksys_write+0x12d/0x250 [ 58.130504][ C0] do_syscall_64+0x35/0xb0 [ 58.135107][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 58.141186][ C0] [ 58.143499][ C0] -> (&group->lock){..-.}-{2:2} { [ 58.148543][ C0] IN-SOFTIRQ-W at: [ 58.152521][ C0] lock_acquire+0x1ab/0x510 [ 58.158691][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 58.165648][ C0] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 58.173029][ C0] snd_pcm_period_elapsed+0x1d/0x50 [ 58.179885][ C0] dummy_hrtimer_callback+0x94/0x1b0 [ 58.186832][ C0] __hrtimer_run_queues+0x609/0xe50 [ 58.193695][ C0] hrtimer_run_softirq+0x17b/0x360 [ 58.200464][ C0] __do_softirq+0x29b/0x9c2 [ 58.206624][ C0] __irq_exit_rcu+0x123/0x180 [ 58.212958][ C0] irq_exit_rcu+0x5/0x20 [ 58.218854][ C0] sysvec_apic_timer_interrupt+0x93/0xc0 [ 58.226138][ C0] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 58.233780][ C0] acpi_idle_do_entry+0x1c6/0x250 [ 58.240471][ C0] acpi_idle_enter+0x361/0x500 [ 58.246896][ C0] cpuidle_enter_state+0x1b1/0xc80 [ 58.253670][ C0] cpuidle_enter+0x4a/0xa0 [ 58.259744][ C0] do_idle+0x3e8/0x590 [ 58.265474][ C0] cpu_startup_entry+0x14/0x20 [ 58.271899][ C0] start_kernel+0x47a/0x49b [ 58.278054][ C0] secondary_startup_64_no_verify+0xb0/0xbb [ 58.285609][ C0] INITIAL USE at: [ 58.289499][ C0] lock_acquire+0x1ab/0x510 [ 58.295572][ C0] _raw_spin_lock_irq+0x32/0x50 [ 58.301997][ C0] snd_pcm_hw_params+0x12a/0x1990 [ 58.308605][ C0] snd_pcm_kernel_ioctl+0x164/0x310 [ 58.315373][ C0] snd_pcm_oss_change_params_locked+0x13c8/0x3bf0 [ 58.323361][ C0] snd_pcm_oss_make_ready_locked+0xb3/0x130 [ 58.330828][ C0] snd_pcm_oss_write+0x4b2/0x9c0 [ 58.337341][ C0] vfs_write+0x28e/0xae0 [ 58.343160][ C0] ksys_write+0x12d/0x250 [ 58.349056][ C0] do_syscall_64+0x35/0xb0 [ 58.355042][ C0] entry_SYSCALL_64_after_hwframe+0x44/0xae [ 58.362515][ C0] } [ 58.365006][ C0] ... key at: [] __key.9+0x0/0x40 [ 58.372121][ C0] ... acquired at: [ 58.375912][ C0] __lock_acquire+0x11d5/0x54a0 [ 58.380940][ C0] lock_acquire+0x1ab/0x510 [ 58.385618][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 58.390996][ C0] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 58.396905][ C0] snd_pcm_period_elapsed+0x1d/0x50 [ 58.402280][ C0] dummy_hrtimer_callback+0x94/0x1b0 [ 58.407749][ C0] __hrtimer_run_queues+0x609/0xe50 [ 58.413127][ C0] hrtimer_run_softirq+0x17b/0x360 [ 58.418413][ C0] __do_softirq+0x29b/0x9c2 [ 58.423099][ C0] __irq_exit_rcu+0x123/0x180 [ 58.427958][ C0] irq_exit_rcu+0x5/0x20 [ 58.432384][ C0] sysvec_apic_timer_interrupt+0x93/0xc0 [ 58.438196][ C0] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 58.444367][ C0] acpi_idle_do_entry+0x1c6/0x250 [ 58.449571][ C0] acpi_idle_enter+0x361/0x500 [ 58.454512][ C0] cpuidle_enter_state+0x1b1/0xc80 [ 58.459805][ C0] cpuidle_enter+0x4a/0xa0 [ 58.464399][ C0] do_idle+0x3e8/0x590 [ 58.468650][ C0] cpu_startup_entry+0x14/0x20 [ 58.473594][ C0] start_kernel+0x47a/0x49b [ 58.478274][ C0] secondary_startup_64_no_verify+0xb0/0xbb [ 58.484349][ C0] [ 58.486661][ C0] [ 58.486661][ C0] stack backtrace: [ 58.492540][ C0] CPU: 0 PID: 0 Comm: swapper/0 Not tainted 5.16.0-rc5-syzkaller #0 [ 58.500523][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 58.510572][ C0] Call Trace: [ 58.513850][ C0] [ 58.516690][ C0] dump_stack_lvl+0xcd/0x134 [ 58.521291][ C0] mark_lock.cold+0x86/0x8e [ 58.525802][ C0] ? lock_chain_count+0x20/0x20 [ 58.530658][ C0] ? lockdep_hardirqs_on+0x79/0x100 [ 58.535863][ C0] ? __lock_acquire+0x162f/0x54a0 [ 58.540901][ C0] __lock_acquire+0x11d5/0x54a0 [ 58.545784][ C0] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 58.551782][ C0] lock_acquire+0x1ab/0x510 [ 58.556298][ C0] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 58.562210][ C0] ? lock_release+0x720/0x720 [ 58.566897][ C0] ? find_held_lock+0x2d/0x110 [ 58.571672][ C0] ? __hrtimer_run_queues+0x51a/0xe50 [ 58.577053][ C0] ? _raw_spin_lock_irqsave+0x4e/0x50 [ 58.582435][ C0] ? dummy_pcm_copy_kernel+0x10/0x10 [ 58.587730][ C0] _raw_spin_lock_irqsave+0x39/0x50 [ 58.592938][ C0] ? _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 58.598931][ C0] _snd_pcm_stream_lock_irqsave+0x9f/0xd0 [ 58.604663][ C0] snd_pcm_period_elapsed+0x1d/0x50 [ 58.609870][ C0] dummy_hrtimer_callback+0x94/0x1b0 [ 58.615169][ C0] __hrtimer_run_queues+0x609/0xe50 [ 58.620378][ C0] ? hrtimer_sleeper_start_expires+0x80/0x80 [ 58.626364][ C0] ? ktime_get_update_offsets_now+0x3eb/0x5c0 [ 58.632444][ C0] hrtimer_run_softirq+0x17b/0x360 [ 58.637562][ C0] __do_softirq+0x29b/0x9c2 [ 58.642078][ C0] __irq_exit_rcu+0x123/0x180 [ 58.646773][ C0] irq_exit_rcu+0x5/0x20 [ 58.651024][ C0] sysvec_apic_timer_interrupt+0x93/0xc0 [ 58.656663][ C0] [ 58.659586][ C0] [ 58.662513][ C0] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 58.668510][ C0] RIP: 0010:acpi_idle_do_entry+0x1c6/0x250 [ 58.674328][ C0] Code: 89 de e8 6d 5e 30 f8 84 db 75 ac e8 84 5a 30 f8 e8 cf 9e 36 f8 eb 0c e8 78 5a 30 f8 0f 00 2d d1 b4 c9 00 e8 6c 5a 30 f8 fb f4 <9c> 5b 81 e3 00 02 00 00 fa 31 ff 48 89 de e8 e7 5c 30 f8 48 85 db [ 58.693939][ C0] RSP: 0018:ffffffff8b807d60 EFLAGS: 00000293 [ 58.700009][ C0] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 0000000000000000 [ 58.707980][ C0] RDX: ffffffff8b8bc6c0 RSI: ffffffff89475854 RDI: 0000000000000000 [ 58.715950][ C0] RBP: ffff888011a74864 R08: 0000000000000001 R09: 0000000000000001 [ 58.723929][ C0] R10: ffffffff817df748 R11: 0000000000000000 R12: 0000000000000001 [ 58.731899][ C0] R13: ffff888011a74800 R14: ffff888011a74864 R15: ffff888145d9c804 [ 58.739874][ C0] ? trace_hardirqs_on+0x38/0x1c0 [ 58.744917][ C0] ? acpi_idle_do_entry+0x1c4/0x250 [ 58.750131][ C0] acpi_idle_enter+0x361/0x500 [ 58.754906][ C0] cpuidle_enter_state+0x1b1/0xc80 [ 58.760033][ C0] cpuidle_enter+0x4a/0xa0 [ 58.764454][ C0] do_idle+0x3e8/0x590 [ 58.768529][ C0] ? arch_cpu_idle_exit+0x30/0x30 [ 58.773562][ C0] ? trace_init_perf_perm_irq_work_exit+0xe/0xe [ 58.779820][ C0] cpu_startup_entry+0x14/0x20 [ 58.784598][ C0] start_kernel+0x47a/0x49b [ 58.789456][ C0] secondary_startup_64_no_verify+0xb0/0xbb [ 58.795362][ C0] [ 58.808127][ T5] Bluetooth: hci0: command 0x0409 tx timeout