[ 57.034611][ T9] bridge0: port 1(bridge_slave_0) entered disabled state [ 57.051029][ T9] device veth1_macvtap left promiscuous mode [ 57.057566][ T9] device veth0_macvtap left promiscuous mode [ 57.063774][ T9] device veth1_vlan left promiscuous mode [ 57.070296][ T9] device veth0_vlan left promiscuous mode [ 57.301796][ T9] team0 (unregistering): Port device team_slave_1 removed [ 57.317883][ T9] team0 (unregistering): Port device team_slave_0 removed [ 57.333416][ T9] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 57.350334][ T9] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 57.439645][ T9] bond0 (unregistering): Released all slaves Warning: Permanently added '10.128.0.82' (ECDSA) to the list of known hosts. 2022/12/07 11:27:47 ignoring optional flag "sandboxArg"="0" 2022/12/07 11:27:48 parsed 1 programs 2022/12/07 11:27:48 executed programs: 0 [ 74.454218][ T4082] cgroup: Unknown subsys name 'net' [ 74.464247][ T4082] cgroup: Unknown subsys name 'rlimit' [ 75.564888][ T48] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 75.572780][ T48] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 75.580725][ T48] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 75.589026][ T48] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 75.597200][ T48] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 75.605362][ T48] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 75.614476][ T4088] Bluetooth: hci0: HCI_REQ-0x0c1a [ 75.686207][ T4088] chnl_net:caif_netlink_parms(): no params data found [ 75.726433][ T4088] bridge0: port 1(bridge_slave_0) entered blocking state [ 75.733728][ T4088] bridge0: port 1(bridge_slave_0) entered disabled state [ 75.741643][ T4088] device bridge_slave_0 entered promiscuous mode [ 75.750005][ T4088] bridge0: port 2(bridge_slave_1) entered blocking state [ 75.757273][ T4088] bridge0: port 2(bridge_slave_1) entered disabled state [ 75.765090][ T4088] device bridge_slave_1 entered promiscuous mode [ 75.785553][ T4088] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 75.796552][ T4088] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 75.819352][ T4088] team0: Port device team_slave_0 added [ 75.828298][ T4088] team0: Port device team_slave_1 added [ 75.845293][ T4088] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 75.852419][ T4088] 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. [ 75.878603][ T4088] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 75.891446][ T4088] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 75.898632][ T4088] 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. [ 75.925271][ T4088] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 75.951763][ T4088] device hsr_slave_0 entered promiscuous mode [ 75.958755][ T4088] device hsr_slave_1 entered promiscuous mode [ 76.020663][ T4088] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.027988][ T4088] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.035281][ T4088] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.042437][ T4088] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.082029][ T4088] 8021q: adding VLAN 0 to HW filter on device bond0 [ 76.095717][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 76.104540][ T3644] bridge0: port 1(bridge_slave_0) entered disabled state [ 76.112641][ T3644] bridge0: port 2(bridge_slave_1) entered disabled state [ 76.121011][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 76.133843][ T4088] 8021q: adding VLAN 0 to HW filter on device team0 [ 76.148730][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 76.158099][ T3644] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.165177][ T3644] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.173298][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 76.182381][ T3644] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.189506][ T3644] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.205716][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 76.215551][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 76.230015][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 76.241280][ T3295] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 76.252466][ T4088] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 76.264149][ T4088] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 76.273088][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 76.290065][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 76.298073][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 76.310450][ T4088] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 76.358563][ T14] cfg80211: failed to load regulatory.db [ 76.877526][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 76.886252][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 76.909276][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 76.918737][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 76.928880][ T4088] device veth0_vlan entered promiscuous mode [ 76.938168][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 76.945942][ T151] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 76.958540][ T4088] device veth1_vlan entered promiscuous mode [ 76.977747][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 76.985925][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 76.994347][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 77.003229][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 77.013609][ T4088] device veth0_macvtap entered promiscuous mode [ 77.023302][ T4088] device veth1_macvtap entered promiscuous mode [ 77.037135][ T4088] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 77.044557][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 77.053604][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 77.061963][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 77.071486][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 77.085407][ T4088] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 77.092973][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 77.101880][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 77.156949][ T1063] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 77.165865][ T1063] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 77.178073][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 77.197005][ T9] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 77.205198][ T9] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 77.216051][ T3644] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 77.637693][ T48] Bluetooth: hci0: command 0x0409 tx timeout [ 78.083739][ T4108] [ 78.086193][ T4108] ====================================================== [ 78.093300][ T4108] WARNING: possible circular locking dependency detected [ 78.100332][ T4108] 6.1.0-rc8-syzkaller-00014-g8ed710da2873 #0 Not tainted [ 78.107343][ T4108] ------------------------------------------------------ [ 78.114447][ T4108] syz-executor.0/4108 is trying to acquire lock: [ 78.120868][ T4108] ffff888074da6130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sk_state_change+0x52/0x2f0 [ 78.132867][ T4108] [ 78.132867][ T4108] but task is already holding lock: [ 78.140549][ T4108] ffff888070355128 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x276/0x470 [ 78.149514][ T4108] [ 78.149514][ T4108] which lock already depends on the new lock. [ 78.149514][ T4108] [ 78.160002][ T4108] [ 78.160002][ T4108] the existing dependency chain (in reverse order) is: [ 78.169280][ T4108] [ 78.169280][ T4108] -> #2 (&d->lock){+.+.}-{3:3}: [ 78.176307][ T4108] lock_acquire+0x1a7/0x400 [ 78.181325][ T4108] __mutex_lock_common+0x1de/0x26c0 [ 78.187045][ T4108] mutex_lock_nested+0x17/0x20 [ 78.192327][ T4108] __rfcomm_dlc_close+0x276/0x470 [ 78.197864][ T4108] rfcomm_dlc_close+0x10d/0x1c0 [ 78.203413][ T4108] __rfcomm_sock_close+0x101/0x220 [ 78.209134][ T4108] rfcomm_sock_shutdown+0xad/0x230 [ 78.214770][ T4108] rfcomm_sock_release+0x55/0x120 [ 78.220492][ T4108] sock_close+0xd7/0x260 [ 78.225432][ T4108] __fput+0x3ba/0x880 [ 78.230046][ T4108] task_work_run+0x243/0x300 [ 78.235417][ T4108] get_signal+0x1642/0x1810 [ 78.240541][ T4108] arch_do_signal_or_restart+0x8d/0x750 [ 78.246596][ T4108] exit_to_user_mode_loop+0x74/0x160 [ 78.252499][ T4108] exit_to_user_mode_prepare+0xad/0x110 [ 78.258572][ T4108] syscall_exit_to_user_mode+0x2e/0x60 [ 78.265257][ T4108] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 78.271839][ T4108] [ 78.271839][ T4108] -> #1 (rfcomm_mutex){+.+.}-{3:3}: [ 78.279226][ T4108] lock_acquire+0x1a7/0x400 [ 78.284938][ T4108] __mutex_lock_common+0x1de/0x26c0 [ 78.290744][ T4108] mutex_lock_nested+0x17/0x20 [ 78.296035][ T4108] rfcomm_dlc_open+0x25/0x50 [ 78.301162][ T4108] rfcomm_sock_connect+0x285/0x470 [ 78.307313][ T4108] __sys_connect+0x29b/0x2d0 [ 78.312694][ T4108] __x64_sys_connect+0x76/0x80 [ 78.317997][ T4108] do_syscall_64+0x2b/0x70 [ 78.322941][ T4108] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 78.329622][ T4108] [ 78.329622][ T4108] -> #0 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}: [ 78.339160][ T4108] validate_chain+0x184a/0x6470 [ 78.344571][ T4108] __lock_acquire+0x1292/0x1f60 [ 78.350336][ T4108] lock_acquire+0x1a7/0x400 [ 78.355445][ T4108] lock_sock_nested+0x44/0xf0 [ 78.360827][ T4108] rfcomm_sk_state_change+0x52/0x2f0 [ 78.366637][ T4108] __rfcomm_dlc_close+0x2bb/0x470 [ 78.372189][ T4108] rfcomm_dlc_close+0x10d/0x1c0 [ 78.377661][ T4108] __rfcomm_sock_close+0x101/0x220 [ 78.383321][ T4108] rfcomm_sock_shutdown+0xad/0x230 [ 78.388980][ T4108] rfcomm_sock_release+0x55/0x120 [ 78.394517][ T4108] sock_close+0xd7/0x260 [ 78.399357][ T4108] __fput+0x3ba/0x880 [ 78.403896][ T4108] task_work_run+0x243/0x300 [ 78.409082][ T4108] get_signal+0x1642/0x1810 [ 78.414463][ T4108] arch_do_signal_or_restart+0x8d/0x750 [ 78.420776][ T4108] exit_to_user_mode_loop+0x74/0x160 [ 78.427177][ T4108] exit_to_user_mode_prepare+0xad/0x110 [ 78.433322][ T4108] syscall_exit_to_user_mode+0x2e/0x60 [ 78.439622][ T4108] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 78.446025][ T4108] [ 78.446025][ T4108] other info that might help us debug this: [ 78.446025][ T4108] [ 78.456495][ T4108] Chain exists of: [ 78.456495][ T4108] sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM --> rfcomm_mutex --> &d->lock [ 78.456495][ T4108] [ 78.470512][ T4108] Possible unsafe locking scenario: [ 78.470512][ T4108] [ 78.477977][ T4108] CPU0 CPU1 [ 78.483331][ T4108] ---- ---- [ 78.488683][ T4108] lock(&d->lock); [ 78.492490][ T4108] lock(rfcomm_mutex); [ 78.499185][ T4108] lock(&d->lock); [ 78.505681][ T4108] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 78.512448][ T4108] [ 78.512448][ T4108] *** DEADLOCK *** [ 78.512448][ T4108] [ 78.521020][ T4108] 3 locks held by syz-executor.0/4108: [ 78.526741][ T4108] #0: ffff888072056e10 (&sb->s_type->i_mutex_key#9){+.+.}-{3:3}, at: sock_close+0x93/0x260 [ 78.537144][ T4108] #1: ffffffff8e5df588 (rfcomm_mutex){+.+.}-{3:3}, at: rfcomm_dlc_close+0x32/0x1c0 [ 78.546806][ T4108] #2: ffff888070355128 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x276/0x470 [ 78.556187][ T4108] [ 78.556187][ T4108] stack backtrace: [ 78.562069][ T4108] CPU: 1 PID: 4108 Comm: syz-executor.0 Not tainted 6.1.0-rc8-syzkaller-00014-g8ed710da2873 #0 [ 78.572490][ T4108] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 78.582653][ T4108] Call Trace: [ 78.585969][ T4108] [ 78.588890][ T4108] dump_stack_lvl+0x1e3/0x2cb [ 78.593563][ T4108] ? nf_tcp_handle_invalid+0x62e/0x62e [ 78.599019][ T4108] ? print_circular_bug+0x13e/0x1c0 [ 78.604214][ T4108] check_noncircular+0x2f9/0x3b0 [ 78.609548][ T4108] ? add_chain_block+0x850/0x850 [ 78.614615][ T4108] ? lockdep_lock+0x11d/0x2a0 [ 78.619377][ T4108] ? _find_first_zero_bit+0xe8/0x110 [ 78.625180][ T4108] validate_chain+0x184a/0x6470 [ 78.630156][ T4108] ? reacquire_held_locks+0x680/0x680 [ 78.635630][ T4108] ? register_lock_class+0xfe/0x9b0 [ 78.641035][ T4108] ? is_dynamic_key+0x1f0/0x1f0 [ 78.645890][ T4108] ? mark_lock+0x9a/0x350 [ 78.650294][ T4108] ? __lock_acquire+0x1292/0x1f60 [ 78.655310][ T4108] ? mark_lock+0x9a/0x350 [ 78.659637][ T4108] __lock_acquire+0x1292/0x1f60 [ 78.664583][ T4108] lock_acquire+0x1a7/0x400 [ 78.669250][ T4108] ? rfcomm_sk_state_change+0x52/0x2f0 [ 78.674704][ T4108] ? read_lock_is_recursive+0x10/0x10 [ 78.680132][ T4108] ? __mutex_lock_common+0x45d/0x26c0 [ 78.685525][ T4108] ? del_timer+0x340/0x3d0 [ 78.689930][ T4108] ? __rfcomm_dlc_close+0x276/0x470 [ 78.695204][ T4108] ? mutex_lock_io_nested+0x60/0x60 [ 78.700481][ T4108] lock_sock_nested+0x44/0xf0 [ 78.705152][ T4108] ? rfcomm_sk_state_change+0x52/0x2f0 [ 78.710694][ T4108] rfcomm_sk_state_change+0x52/0x2f0 [ 78.716055][ T4108] __rfcomm_dlc_close+0x2bb/0x470 [ 78.721240][ T4108] rfcomm_dlc_close+0x10d/0x1c0 [ 78.726078][ T4108] __rfcomm_sock_close+0x101/0x220 [ 78.731217][ T4108] rfcomm_sock_shutdown+0xad/0x230 [ 78.736323][ T4108] rfcomm_sock_release+0x55/0x120 [ 78.741337][ T4108] sock_close+0xd7/0x260 [ 78.745571][ T4108] ? __fput+0x3b2/0x880 [ 78.749729][ T4108] ? sock_mmap+0x90/0x90 [ 78.753958][ T4108] __fput+0x3ba/0x880 [ 78.757936][ T4108] task_work_run+0x243/0x300 [ 78.762517][ T4108] ? task_work_cancel+0x290/0x290 [ 78.767539][ T4108] get_signal+0x1642/0x1810 [ 78.772040][ T4108] ? kick_process+0xd6/0x140 [ 78.776734][ T4108] ? task_work_add+0x2e6/0x340 [ 78.782112][ T4108] ? rcu_lock_release+0x20/0x20 [ 78.786955][ T4108] ? ptrace_notify+0x340/0x340 [ 78.791707][ T4108] arch_do_signal_or_restart+0x8d/0x750 [ 78.797344][ T4108] ? __sys_connect+0x157/0x2d0 [ 78.802107][ T4108] ? get_sigframe_size+0x10/0x10 [ 78.807315][ T4108] ? exit_to_user_mode_loop+0x42/0x160 [ 78.812766][ T4108] exit_to_user_mode_loop+0x74/0x160 [ 78.818055][ T4108] exit_to_user_mode_prepare+0xad/0x110 [ 78.823705][ T4108] syscall_exit_to_user_mode+0x2e/0x60 [ 78.829183][ T4108] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 78.835403][ T4108] RIP: 0033:0x7f0fc1889049 [ 78.840268][ T4108] 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 b8 ff ff ff f7 d8 64 89 01 48 [ 78.860662][ T4108] RSP: 002b:00007f0fc2996168 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 78.869097][ T4108] RAX: fffffffffffffffc RBX: 00007f0fc199bf60 RCX: 00007f0fc1889049 [ 78.877070][ T4108] RDX: 0000000000000080 RSI: 0000000020000000 RDI: 0000000000000004 [ 78.885133][ T4108] RBP: 00007f0fc18e308d R08: 0000000000000000 R09: 0000000000000000 [ 78.893279][ T4108] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 78.901455][ T4108] R13: 00007ffdb6f60c6f R14: 00007f0fc2996300 R15: 0000000000022000 [ 78.909441][ T4108] 2022/12/07 11:27:53 executed programs: 2 [ 79.716760][ T48] Bluetooth: hci0: command 0x041b tx timeout [ 81.796859][ T48] Bluetooth: hci0: command 0x040f tx timeout [ 83.876945][ T48] Bluetooth: hci0: command 0x0419 tx timeout 2022/12/07 11:27:58 executed programs: 8 [ 85.956751][ T48] Bluetooth: hci0: command 0x0405 tx timeout