[ 58.986083][ T51] bridge0: port 1(bridge_slave_0) entered disabled state [ 59.013664][ T51] device veth1_macvtap left promiscuous mode [ 59.022887][ T51] device veth0_macvtap left promiscuous mode [ 59.030574][ T51] device veth1_vlan left promiscuous mode [ 59.036743][ T51] device veth0_vlan left promiscuous mode [ 59.288693][ T51] team0 (unregistering): Port device team_slave_1 removed [ 59.306071][ T51] team0 (unregistering): Port device team_slave_0 removed [ 59.325500][ T51] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 59.343306][ T51] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 59.399397][ T51] bond0 (unregistering): Released all slaves [ 76.370786][ T14] cfg80211: failed to load regulatory.db Warning: Permanently added '10.128.10.42' (ECDSA) to the list of known hosts. 2022/09/19 09:33:27 ignoring optional flag "sandboxArg"="0" 2022/09/19 09:33:27 parsed 1 programs 2022/09/19 09:33:27 executed programs: 0 [ 78.374339][ T47] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 78.382701][ T47] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 78.390874][ T47] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 78.399905][ T47] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 78.407902][ T47] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 78.416006][ T47] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 78.491743][ T4077] chnl_net:caif_netlink_parms(): no params data found [ 78.531578][ T4077] bridge0: port 1(bridge_slave_0) entered blocking state [ 78.539204][ T4077] bridge0: port 1(bridge_slave_0) entered disabled state [ 78.547007][ T4077] device bridge_slave_0 entered promiscuous mode [ 78.555310][ T4077] bridge0: port 2(bridge_slave_1) entered blocking state [ 78.563642][ T4077] bridge0: port 2(bridge_slave_1) entered disabled state [ 78.572292][ T4077] device bridge_slave_1 entered promiscuous mode [ 78.593360][ T4077] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 78.604919][ T4077] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 78.629262][ T4077] team0: Port device team_slave_0 added [ 78.636883][ T4077] team0: Port device team_slave_1 added [ 78.654773][ T4077] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 78.661943][ T4077] 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. [ 78.688986][ T4077] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 78.701194][ T4077] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 78.708277][ T4077] 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. [ 78.734594][ T4077] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 78.761877][ T4077] device hsr_slave_0 entered promiscuous mode [ 78.768817][ T4077] device hsr_slave_1 entered promiscuous mode [ 78.829898][ T4077] bridge0: port 2(bridge_slave_1) entered blocking state [ 78.837083][ T4077] bridge0: port 2(bridge_slave_1) entered forwarding state [ 78.844474][ T4077] bridge0: port 1(bridge_slave_0) entered blocking state [ 78.851786][ T4077] bridge0: port 1(bridge_slave_0) entered forwarding state [ 78.892942][ T4077] 8021q: adding VLAN 0 to HW filter on device bond0 [ 78.905608][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 78.915008][ T3271] bridge0: port 1(bridge_slave_0) entered disabled state [ 78.923539][ T3271] bridge0: port 2(bridge_slave_1) entered disabled state [ 78.931540][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 78.943920][ T4077] 8021q: adding VLAN 0 to HW filter on device team0 [ 78.955234][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 78.964196][ T3271] bridge0: port 1(bridge_slave_0) entered blocking state [ 78.971425][ T3271] bridge0: port 1(bridge_slave_0) entered forwarding state [ 78.982778][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 78.992020][ T141] bridge0: port 2(bridge_slave_1) entered blocking state [ 78.999286][ T141] bridge0: port 2(bridge_slave_1) entered forwarding state [ 79.021481][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 79.031089][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 79.039736][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 79.052817][ T4077] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 79.065082][ T4077] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 79.073420][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 79.081426][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 79.099460][ T3627] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 79.106934][ T3627] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 79.116700][ T4077] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 79.326304][ T4077] device veth0_vlan entered promiscuous mode [ 79.334403][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 79.343876][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 79.353270][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 79.361855][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 79.373492][ T4077] device veth1_vlan entered promiscuous mode [ 79.382942][ T3627] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 79.402095][ T3627] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 79.411146][ T3627] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 79.422056][ T4077] device veth0_macvtap entered promiscuous mode [ 79.433254][ T4077] device veth1_macvtap entered promiscuous mode [ 79.450378][ T4077] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 79.459800][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 79.470574][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 79.482233][ T4077] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 79.491003][ T3271] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 80.387632][ T4096] [ 80.390162][ T4096] ============================================ [ 80.396402][ T4096] WARNING: possible recursive locking detected [ 80.403146][ T4096] 6.0.0-rc4-syzkaller-00985-g44a8535fb87c #0 Not tainted [ 80.410347][ T4096] -------------------------------------------- [ 80.417647][ T4096] syz-executor.0/4096 is trying to acquire lock: [ 80.424664][ T4096] ffff88807a584130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sk_state_change+0x69/0x3a0 [ 80.436609][ T4096] [ 80.436609][ T4096] but task is already holding lock: [ 80.444588][ T4096] ffff88807a584130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sock_shutdown+0x52/0x210 [ 80.455906][ T4096] [ 80.455906][ T4096] other info that might help us debug this: [ 80.464071][ T4096] Possible unsafe locking scenario: [ 80.464071][ T4096] [ 80.471631][ T4096] CPU0 [ 80.474922][ T4096] ---- [ 80.478282][ T4096] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 80.484432][ T4096] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 80.488782][ T26] Bluetooth: hci0: command 0x0409 tx timeout [ 80.490573][ T4096] [ 80.490573][ T4096] *** DEADLOCK *** [ 80.490573][ T4096] [ 80.490579][ T4096] May be due to missing lock nesting notation [ 80.490579][ T4096] [ 80.490585][ T4096] 4 locks held by syz-executor.0/4096: [ 80.518665][ T4096] #0: ffff88807ec7be10 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: __sock_release+0x86/0x280 [ 80.529318][ T4096] #1: ffff88807a584130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sock_shutdown+0x52/0x210 [ 80.541242][ T4096] #2: ffffffff8da00ac8 (rfcomm_mutex){+.+.}-{3:3}, at: rfcomm_dlc_close+0x2f/0x240 [ 80.550835][ T4096] #3: ffff888078cb4528 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x15d/0x890 [ 80.560590][ T4096] [ 80.560590][ T4096] stack backtrace: [ 80.567353][ T4096] CPU: 0 PID: 4096 Comm: syz-executor.0 Not tainted 6.0.0-rc4-syzkaller-00985-g44a8535fb87c #0 [ 80.580567][ T4096] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 08/26/2022 [ 80.590854][ T4096] Call Trace: [ 80.594190][ T4096] [ 80.597346][ T4096] dump_stack_lvl+0xcd/0x134 [ 80.601998][ T4096] __lock_acquire.cold+0x116/0x3a7 [ 80.607161][ T4096] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 80.613252][ T4096] lock_acquire+0x1ab/0x570 [ 80.617874][ T4096] ? rfcomm_sk_state_change+0x69/0x3a0 [ 80.623522][ T4096] ? lock_release+0x780/0x780 [ 80.628322][ T4096] ? __rfcomm_dlc_close+0x15d/0x890 [ 80.633970][ T4096] ? mutex_lock_io_nested+0x1190/0x1190 [ 80.639703][ T4096] ? lockdep_hardirqs_on+0x79/0x100 [ 80.644950][ T4096] ? del_timer+0xc5/0x110 [ 80.649565][ T4096] lock_sock_nested+0x36/0xf0 [ 80.654350][ T4096] ? rfcomm_sk_state_change+0x69/0x3a0 [ 80.660002][ T4096] rfcomm_sk_state_change+0x69/0x3a0 [ 80.665298][ T4096] __rfcomm_dlc_close+0x1b1/0x890 [ 80.670427][ T4096] rfcomm_dlc_close+0x1e5/0x240 [ 80.675455][ T4096] ? __sanitizer_cov_trace_switch+0x50/0x90 [ 80.681905][ T4096] __rfcomm_sock_close+0x13c/0x250 [ 80.687307][ T4096] ? lockdep_hardirqs_on+0x79/0x100 [ 80.692604][ T4096] rfcomm_sock_shutdown+0xcc/0x210 [ 80.697959][ T4096] rfcomm_sock_release+0x64/0x140 [ 80.703277][ T4096] __sock_release+0xcd/0x280 [ 80.708160][ T4096] sock_close+0x18/0x20 [ 80.712409][ T4096] __fput+0x277/0x9d0 [ 80.716487][ T4096] ? __sock_release+0x280/0x280 [ 80.721431][ T4096] task_work_run+0xdd/0x1a0 [ 80.725929][ T4096] get_signal+0x1c3/0x2610 [ 80.730441][ T4096] ? rfcomm_sock_connect+0x155/0x450 [ 80.736016][ T4096] ? lock_downgrade+0x6e0/0x6e0 [ 80.740875][ T4096] ? exit_signals+0x8b0/0x8b0 [ 80.745637][ T4096] ? __local_bh_enable_ip+0xa0/0x120 [ 80.750963][ T4096] ? __local_bh_enable_ip+0xa0/0x120 [ 80.756514][ T4096] arch_do_signal_or_restart+0x82/0x2300 [ 80.762273][ T4096] ? task_work_add+0xa4/0x1f0 [ 80.767143][ T4096] ? fput+0xf2/0x190 [ 80.771144][ T4096] ? get_sigframe_size+0x10/0x10 [ 80.776181][ T4096] ? __sys_connect_file+0x190/0x190 [ 80.781586][ T4096] ? exit_to_user_mode_prepare+0x137/0x250 [ 80.787686][ T4096] exit_to_user_mode_prepare+0x15f/0x250 [ 80.794116][ T4096] syscall_exit_to_user_mode+0x19/0x50 [ 80.799847][ T4096] do_syscall_64+0x42/0xb0 [ 80.804364][ T4096] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 80.810374][ T4096] RIP: 0033:0x4665e9 [ 80.814444][ T4096] 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 [ 80.834322][ T4096] RSP: 002b:00007fcec9d31188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 80.842815][ T4096] RAX: fffffffffffffffc RBX: 000000000056bf80 RCX: 00000000004665e9 [ 80.851160][ T4096] RDX: 000000000000005a RSI: 0000000020000000 RDI: 0000000000000004 [ 80.859232][ T4096] RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000 [ 80.867375][ T4096] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 [ 80.875456][ T4096] R13: 00007fffccce7c2f R14: 00007fcec9d31300 R15: 0000000000022000 [ 80.883430][ T4096] [ 82.928745][ T3271] Bluetooth: hci0: command 0x041b tx timeout [ 85.009000][ T3271] Bluetooth: hci0: command 0x040f tx timeout [ 87.088210][ T3271] Bluetooth: hci0: command 0x0419 tx timeout [ 89.168223][ T3271] Bluetooth: hci0: command 0x0405 tx timeout