[ 57.748489][ T1087] bridge0: port 1(bridge_slave_0) entered disabled state [ 57.770362][ T1087] device veth1_macvtap left promiscuous mode [ 57.778136][ T1087] device veth0_macvtap left promiscuous mode [ 57.785711][ T1087] device veth1_vlan left promiscuous mode [ 57.791857][ T1087] device veth0_vlan left promiscuous mode [ 58.023000][ T1087] team0 (unregistering): Port device team_slave_1 removed [ 58.037008][ T1087] team0 (unregistering): Port device team_slave_0 removed [ 58.050564][ T1087] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 58.065336][ T1087] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 58.116820][ T1087] bond0 (unregistering): Released all slaves Warning: Permanently added '10.128.0.167' (ECDSA) to the list of known hosts. 2022/09/18 21:23:35 ignoring optional flag "sandboxArg"="0" 2022/09/18 21:23:35 parsed 1 programs 2022/09/18 21:23:36 executed programs: 0 [ 76.366603][ T1156] cfg80211: failed to load regulatory.db [ 77.088945][ T48] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 77.097719][ T48] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 77.105960][ T48] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 77.114218][ T48] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 77.121996][ T48] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 77.129991][ T48] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 77.204042][ T4067] chnl_net:caif_netlink_parms(): no params data found [ 77.241500][ T4067] bridge0: port 1(bridge_slave_0) entered blocking state [ 77.249797][ T4067] bridge0: port 1(bridge_slave_0) entered disabled state [ 77.257732][ T4067] device bridge_slave_0 entered promiscuous mode [ 77.266474][ T4067] bridge0: port 2(bridge_slave_1) entered blocking state [ 77.273716][ T4067] bridge0: port 2(bridge_slave_1) entered disabled state [ 77.281733][ T4067] device bridge_slave_1 entered promiscuous mode [ 77.301656][ T4067] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 77.312759][ T4067] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 77.335322][ T4067] team0: Port device team_slave_0 added [ 77.343158][ T4067] team0: Port device team_slave_1 added [ 77.362071][ T4067] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 77.369215][ T4067] 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. [ 77.396302][ T4067] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 77.408676][ T4067] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 77.416040][ T4067] 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. [ 77.442401][ T4067] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 77.468899][ T4067] device hsr_slave_0 entered promiscuous mode [ 77.475548][ T4067] device hsr_slave_1 entered promiscuous mode [ 77.534787][ T4067] bridge0: port 2(bridge_slave_1) entered blocking state [ 77.541861][ T4067] bridge0: port 2(bridge_slave_1) entered forwarding state [ 77.549516][ T4067] bridge0: port 1(bridge_slave_0) entered blocking state [ 77.556721][ T4067] bridge0: port 1(bridge_slave_0) entered forwarding state [ 77.596061][ T4067] 8021q: adding VLAN 0 to HW filter on device bond0 [ 77.608106][ T2253] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 77.617823][ T2253] bridge0: port 1(bridge_slave_0) entered disabled state [ 77.626692][ T2253] bridge0: port 2(bridge_slave_1) entered disabled state [ 77.635170][ T2253] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 77.648102][ T4067] 8021q: adding VLAN 0 to HW filter on device team0 [ 77.658201][ T1156] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 77.667978][ T1156] bridge0: port 1(bridge_slave_0) entered blocking state [ 77.675088][ T1156] bridge0: port 1(bridge_slave_0) entered forwarding state [ 77.697270][ T3621] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 77.706138][ T3621] bridge0: port 2(bridge_slave_1) entered blocking state [ 77.713482][ T3621] bridge0: port 2(bridge_slave_1) entered forwarding state [ 77.722529][ T3621] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 77.731197][ T3621] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 77.745564][ T4067] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 77.758545][ T4067] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 77.770747][ T1156] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 77.778891][ T1156] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 77.787491][ T1156] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 77.800915][ T1156] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 77.817211][ T4067] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 77.825705][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 77.833111][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 78.024930][ T2253] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 78.039729][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 78.049363][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 78.058173][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 78.067472][ T4067] device veth0_vlan entered promiscuous mode [ 78.079125][ T4067] device veth1_vlan entered promiscuous mode [ 78.098208][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 78.107045][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 78.116024][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 78.126610][ T4067] device veth0_macvtap entered promiscuous mode [ 78.136682][ T4067] device veth1_macvtap entered promiscuous mode [ 78.151589][ T4067] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 78.160088][ T2253] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 78.169530][ T2253] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 78.180833][ T4067] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 78.188713][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 79.082606][ T4087] [ 79.084984][ T4087] ============================================ [ 79.091195][ T4087] WARNING: possible recursive locking detected [ 79.097336][ T4087] 6.0.0-rc4-syzkaller-00985-g44a8535fb87c #0 Not tainted [ 79.104629][ T4087] -------------------------------------------- [ 79.110771][ T4087] syz-executor.0/4087 is trying to acquire lock: [ 79.117200][ T4087] ffff88807ec84130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sk_state_change+0x69/0x3a0 [ 79.128710][ T4087] [ 79.128710][ T4087] but task is already holding lock: [ 79.136077][ T4087] ffff88807ec84130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sock_shutdown+0x52/0x210 [ 79.147483][ T4087] [ 79.147483][ T4087] other info that might help us debug this: [ 79.155632][ T4087] Possible unsafe locking scenario: [ 79.155632][ T4087] [ 79.163286][ T4087] CPU0 [ 79.164673][ T1156] Bluetooth: hci0: command 0x0409 tx timeout [ 79.166651][ T4087] ---- [ 79.166656][ T4087] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 79.182158][ T4087] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 79.188409][ T4087] [ 79.188409][ T4087] *** DEADLOCK *** [ 79.188409][ T4087] [ 79.197156][ T4087] May be due to missing lock nesting notation [ 79.197156][ T4087] [ 79.205483][ T4087] 4 locks held by syz-executor.0/4087: [ 79.210933][ T4087] #0: ffff88806cce7410 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: __sock_release+0x86/0x280 [ 79.221488][ T4087] #1: ffff88807ec84130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sock_shutdown+0x52/0x210 [ 79.233326][ T4087] #2: ffffffff8da00ac8 (rfcomm_mutex){+.+.}-{3:3}, at: rfcomm_dlc_close+0x2f/0x240 [ 79.242732][ T4087] #3: ffff888023d2a928 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x15d/0x890 [ 79.252061][ T4087] [ 79.252061][ T4087] stack backtrace: [ 79.257942][ T4087] CPU: 1 PID: 4087 Comm: syz-executor.0 Not tainted 6.0.0-rc4-syzkaller-00985-g44a8535fb87c #0 [ 79.268529][ T4087] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 79.278597][ T4087] Call Trace: [ 79.281868][ T4087] [ 79.284827][ T4087] dump_stack_lvl+0xcd/0x134 [ 79.289461][ T4087] __lock_acquire.cold+0x116/0x3a7 [ 79.294688][ T4087] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 79.300885][ T4087] lock_acquire+0x1ab/0x570 [ 79.305411][ T4087] ? rfcomm_sk_state_change+0x69/0x3a0 [ 79.310880][ T4087] ? lock_release+0x780/0x780 [ 79.315751][ T4087] ? __rfcomm_dlc_close+0x15d/0x890 [ 79.320952][ T4087] ? mutex_lock_io_nested+0x1190/0x1190 [ 79.326501][ T4087] ? lockdep_hardirqs_on+0x79/0x100 [ 79.331710][ T4087] ? del_timer+0xc5/0x110 [ 79.336039][ T4087] lock_sock_nested+0x36/0xf0 [ 79.340712][ T4087] ? rfcomm_sk_state_change+0x69/0x3a0 [ 79.346180][ T4087] rfcomm_sk_state_change+0x69/0x3a0 [ 79.351470][ T4087] __rfcomm_dlc_close+0x1b1/0x890 [ 79.356491][ T4087] rfcomm_dlc_close+0x1e5/0x240 [ 79.361336][ T4087] ? __sanitizer_cov_trace_switch+0x50/0x90 [ 79.367230][ T4087] __rfcomm_sock_close+0x13c/0x250 [ 79.372338][ T4087] ? lockdep_hardirqs_on+0x79/0x100 [ 79.377529][ T4087] rfcomm_sock_shutdown+0xcc/0x210 [ 79.382762][ T4087] rfcomm_sock_release+0x64/0x140 [ 79.387802][ T4087] __sock_release+0xcd/0x280 [ 79.392438][ T4087] sock_close+0x18/0x20 [ 79.396683][ T4087] __fput+0x277/0x9d0 [ 79.400700][ T4087] ? __sock_release+0x280/0x280 [ 79.405843][ T4087] task_work_run+0xdd/0x1a0 [ 79.410345][ T4087] get_signal+0x1c3/0x2610 [ 79.415003][ T4087] ? rfcomm_sock_connect+0x155/0x450 [ 79.420372][ T4087] ? lock_downgrade+0x6e0/0x6e0 [ 79.425742][ T4087] ? exit_signals+0x8b0/0x8b0 [ 79.430474][ T4087] ? __local_bh_enable_ip+0xa0/0x120 [ 79.436026][ T4087] ? __local_bh_enable_ip+0xa0/0x120 [ 79.441416][ T4087] arch_do_signal_or_restart+0x82/0x2300 [ 79.447079][ T4087] ? task_work_add+0xa4/0x1f0 [ 79.451759][ T4087] ? fput+0xf2/0x190 [ 79.455722][ T4087] ? get_sigframe_size+0x10/0x10 [ 79.460657][ T4087] ? __sys_connect_file+0x190/0x190 [ 79.465936][ T4087] ? exit_to_user_mode_prepare+0x137/0x250 [ 79.471748][ T4087] exit_to_user_mode_prepare+0x15f/0x250 [ 79.477390][ T4087] syscall_exit_to_user_mode+0x19/0x50 [ 79.482855][ T4087] do_syscall_64+0x42/0xb0 [ 79.487274][ T4087] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 79.493163][ T4087] RIP: 0033:0x4665f9 [ 79.497054][ T4087] Code: ff ff c3 66 2e 0f 1f 84 00 00 00 00 00 0f 1f 40 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 73 01 c3 48 c7 c1 bc ff ff ff f7 d8 64 89 01 48 [ 79.516754][ T4087] RSP: 002b:00007f0a5e4ac188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 79.526714][ T4087] RAX: fffffffffffffffc RBX: 000000000056bf80 RCX: 00000000004665f9 [ 79.534857][ T4087] RDX: 0000000000000080 RSI: 0000000020000000 RDI: 0000000000000004 [ 79.542845][ T4087] RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000 [ 79.550898][ T4087] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 [ 79.558871][ T4087] R13: 00007ffc527df0cf R14: 00007f0a5e4ac300 R15: 0000000000022000 [ 79.566900][ T4087] [ 81.244244][ T1156] Bluetooth: hci0: command 0x041b tx timeout [ 83.324536][ T1156] Bluetooth: hci0: command 0x040f tx timeout [ 85.404311][ T1156] Bluetooth: hci0: command 0x0419 tx timeout [ 87.484288][ T1156] Bluetooth: hci0: command 0x0405 tx timeout