[ 76.637319][ T26] cfg80211: failed to load regulatory.db Warning: Permanently added '10.128.1.187' (ECDSA) to the list of known hosts. 2023/03/31 08:15:22 ignoring optional flag "sandboxArg"="0" 2023/03/31 08:15:22 parsed 1 programs 2023/03/31 08:15:22 executed programs: 0 [ 78.810882][ T4397] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 78.819091][ T4397] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 78.827888][ T4397] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 78.836163][ T4397] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 78.843639][ T4397] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 78.944377][ T5547] chnl_net:caif_netlink_parms(): no params data found [ 78.984167][ T5547] bridge0: port 1(bridge_slave_0) entered blocking state [ 78.991586][ T5547] bridge0: port 1(bridge_slave_0) entered disabled state [ 78.998958][ T5547] bridge_slave_0: entered allmulticast mode [ 79.005726][ T5547] bridge_slave_0: entered promiscuous mode [ 79.013790][ T5547] bridge0: port 2(bridge_slave_1) entered blocking state [ 79.021124][ T5547] bridge0: port 2(bridge_slave_1) entered disabled state [ 79.028413][ T5547] bridge_slave_1: entered allmulticast mode [ 79.034906][ T5547] bridge_slave_1: entered promiscuous mode [ 79.053930][ T5547] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 79.066202][ T5547] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 79.089124][ T5547] team0: Port device team_slave_0 added [ 79.096600][ T5547] team0: Port device team_slave_1 added [ 79.114622][ T5547] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 79.121891][ T5547] 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. [ 79.148289][ T5547] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 79.161500][ T5547] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 79.168713][ T5547] 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. [ 79.195288][ T5547] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 79.223268][ T5547] hsr_slave_0: entered promiscuous mode [ 79.229561][ T5547] hsr_slave_1: entered promiscuous mode [ 79.909836][ T5547] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 79.919958][ T5547] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 79.931950][ T5547] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 79.943091][ T5547] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 79.968812][ T5547] bridge0: port 2(bridge_slave_1) entered blocking state [ 79.976311][ T5547] bridge0: port 2(bridge_slave_1) entered forwarding state [ 79.983740][ T5547] bridge0: port 1(bridge_slave_0) entered blocking state [ 79.990946][ T5547] bridge0: port 1(bridge_slave_0) entered forwarding state [ 80.001544][ T26] bridge0: port 1(bridge_slave_0) entered disabled state [ 80.010674][ T26] bridge0: port 2(bridge_slave_1) entered disabled state [ 80.081312][ T5547] 8021q: adding VLAN 0 to HW filter on device bond0 [ 80.097294][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 80.108889][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 80.120477][ T5547] 8021q: adding VLAN 0 to HW filter on device team0 [ 80.133969][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 80.143559][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 80.154156][ T26] bridge0: port 1(bridge_slave_0) entered blocking state [ 80.161356][ T26] bridge0: port 1(bridge_slave_0) entered forwarding state [ 80.181459][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 80.192241][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 80.202478][ T5095] bridge0: port 2(bridge_slave_1) entered blocking state [ 80.209720][ T5095] bridge0: port 2(bridge_slave_1) entered forwarding state [ 80.218021][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 80.228044][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 80.244777][ T5547] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 80.256594][ T5547] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 80.269559][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 80.278429][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 80.287655][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 80.296474][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 80.304928][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 80.313479][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 80.322888][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 80.331679][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 80.340647][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 80.348747][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 80.569534][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 80.577660][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 80.591688][ T5547] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 80.615434][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 80.626976][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 80.648118][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 80.658204][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 80.669060][ T5547] veth0_vlan: entered promiscuous mode [ 80.676666][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 80.684644][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 80.698017][ T5547] veth1_vlan: entered promiscuous mode [ 80.721979][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 80.730816][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 80.739870][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 80.748657][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 80.759856][ T5547] veth0_macvtap: entered promiscuous mode [ 80.771936][ T5547] veth1_macvtap: entered promiscuous mode [ 80.790809][ T5547] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 80.799760][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 80.809516][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 80.818214][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 80.827248][ T22] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 80.839033][ T5547] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 80.848819][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 80.858507][ T5095] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 80.869800][ T5547] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 80.878842][ T5087] Bluetooth: hci0: command 0x0409 tx timeout [ 80.887931][ T5547] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 80.897764][ T5547] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 80.906919][ T5547] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 80.972479][ T10] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 80.993794][ T10] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 81.003282][ T41] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 81.013132][ T41] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 81.024011][ T5097] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 81.038863][ T5097] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 81.150851][ T5603] [ 81.153218][ T5603] ====================================================== [ 81.160332][ T5603] WARNING: possible circular locking dependency detected [ 81.167361][ T5603] 6.3.0-rc4-next-20230330-syzkaller-dirty #0 Not tainted [ 81.174414][ T5603] ------------------------------------------------------ [ 81.181594][ T5603] syz-executor.0/5603 is trying to acquire lock: [ 81.187921][ T5603] ffff88801e179130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_dev_ioctl+0x9ca/0x1cb0 [ 81.199689][ T5603] [ 81.199689][ T5603] but task is already holding lock: [ 81.207160][ T5603] ffffffff8e35cc88 (rfcomm_ioctl_mutex){+.+.}-{3:3}, at: rfcomm_dev_ioctl+0x8a2/0x1cb0 [ 81.216948][ T5603] [ 81.216948][ T5603] which lock already depends on the new lock. [ 81.216948][ T5603] [ 81.227736][ T5603] [ 81.227736][ T5603] the existing dependency chain (in reverse order) is: [ 81.236854][ T5603] [ 81.236854][ T5603] -> #1 (rfcomm_ioctl_mutex){+.+.}-{3:3}: [ 81.244796][ T5603] __mutex_lock+0x12f/0x1350 [ 81.250120][ T5603] rfcomm_dev_ioctl+0x8a2/0x1cb0 [ 81.255608][ T5603] rfcomm_sock_ioctl+0xb7/0xe0 [ 81.260946][ T5603] sock_do_ioctl+0xcc/0x230 [ 81.266093][ T5603] sock_ioctl+0x1f8/0x680 [ 81.270979][ T5603] __x64_sys_ioctl+0x197/0x210 [ 81.276292][ T5603] do_syscall_64+0x39/0xb0 [ 81.281269][ T5603] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 81.287928][ T5603] [ 81.287928][ T5603] -> #0 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}: [ 81.297433][ T5603] __lock_acquire+0x2f21/0x5df0 [ 81.302842][ T5603] lock_acquire.part.0+0x11c/0x370 [ 81.308642][ T5603] lock_sock_nested+0x3a/0xf0 [ 81.313872][ T5603] rfcomm_dev_ioctl+0x9ca/0x1cb0 [ 81.319359][ T5603] rfcomm_sock_ioctl+0xb7/0xe0 [ 81.324787][ T5603] sock_do_ioctl+0xcc/0x230 [ 81.329847][ T5603] sock_ioctl+0x1f8/0x680 [ 81.334835][ T5603] __x64_sys_ioctl+0x197/0x210 [ 81.340152][ T5603] do_syscall_64+0x39/0xb0 [ 81.345128][ T5603] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 81.351610][ T5603] [ 81.351610][ T5603] other info that might help us debug this: [ 81.351610][ T5603] [ 81.361945][ T5603] Possible unsafe locking scenario: [ 81.361945][ T5603] [ 81.369868][ T5603] CPU0 CPU1 [ 81.375684][ T5603] ---- ---- [ 81.381149][ T5603] lock(rfcomm_ioctl_mutex); [ 81.386025][ T5603] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 81.394807][ T5603] lock(rfcomm_ioctl_mutex); [ 81.402119][ T5603] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 81.408398][ T5603] [ 81.408398][ T5603] *** DEADLOCK *** [ 81.408398][ T5603] [ 81.416726][ T5603] 1 lock held by syz-executor.0/5603: [ 81.422226][ T5603] #0: ffffffff8e35cc88 (rfcomm_ioctl_mutex){+.+.}-{3:3}, at: rfcomm_dev_ioctl+0x8a2/0x1cb0 [ 81.433857][ T5603] [ 81.433857][ T5603] stack backtrace: [ 81.439757][ T5603] CPU: 0 PID: 5603 Comm: syz-executor.0 Not tainted 6.3.0-rc4-next-20230330-syzkaller-dirty #0 [ 81.450364][ T5603] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 03/02/2023 [ 81.460619][ T5603] Call Trace: [ 81.464029][ T5603] [ 81.466976][ T5603] dump_stack_lvl+0xd9/0x150 [ 81.471697][ T5603] check_noncircular+0x25f/0x2e0 [ 81.476673][ T5603] ? print_circular_bug+0x730/0x730 [ 81.481904][ T5603] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 81.488067][ T5603] ? lockdep_unlock+0x11b/0x290 [ 81.493002][ T5603] __lock_acquire+0x2f21/0x5df0 [ 81.497899][ T5603] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 81.504263][ T5603] ? lock_downgrade+0x690/0x690 [ 81.509187][ T5603] ? rcu_is_watching+0x12/0xb0 [ 81.514080][ T5603] ? __mutex_lock+0x231/0x1350 [ 81.518873][ T5603] lock_acquire.part.0+0x11c/0x370 [ 81.524050][ T5603] ? rfcomm_dev_ioctl+0x9ca/0x1cb0 [ 81.529308][ T5603] ? lock_sync+0x190/0x190 [ 81.534019][ T5603] ? rcu_is_watching+0x12/0xb0 [ 81.538858][ T5603] ? trace_lock_acquire+0x12d/0x180 [ 81.544107][ T5603] ? rfcomm_session_del+0x220/0x220 [ 81.549349][ T5603] ? rfcomm_dev_ioctl+0x9ca/0x1cb0 [ 81.554583][ T5603] ? lock_acquire+0x32/0xc0 [ 81.559142][ T5603] ? rfcomm_dev_ioctl+0x9ca/0x1cb0 [ 81.564293][ T5603] lock_sock_nested+0x3a/0xf0 [ 81.569010][ T5603] ? rfcomm_dev_ioctl+0x9ca/0x1cb0 [ 81.574190][ T5603] rfcomm_dev_ioctl+0x9ca/0x1cb0 [ 81.579167][ T5603] ? rfcomm_dev_state_change+0x170/0x170 [ 81.585010][ T5603] ? lock_downgrade+0x690/0x690 [ 81.589994][ T5603] ? mark_held_locks+0x9f/0xe0 [ 81.594792][ T5603] ? __local_bh_enable_ip+0xa4/0x130 [ 81.600116][ T5603] rfcomm_sock_ioctl+0xb7/0xe0 [ 81.604933][ T5603] sock_do_ioctl+0xcc/0x230 [ 81.609693][ T5603] ? get_user_ifreq+0x250/0x250 [ 81.614581][ T5603] ? vfs_fileattr_set+0xc40/0xc40 [ 81.619652][ T5603] sock_ioctl+0x1f8/0x680 [ 81.624022][ T5603] ? br_ioctl_call+0xb0/0xb0 [ 81.628654][ T5603] ? receive_fd+0x110/0x110 [ 81.633299][ T5603] ? __fget_files+0x26a/0x480 [ 81.638103][ T5603] ? bpf_lsm_file_ioctl+0x9/0x10 [ 81.643087][ T5603] ? br_ioctl_call+0xb0/0xb0 [ 81.647814][ T5603] __x64_sys_ioctl+0x197/0x210 [ 81.652746][ T5603] do_syscall_64+0x39/0xb0 [ 81.657207][ T5603] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 81.663138][ T5603] RIP: 0033:0x7f94d848c0f9 [ 81.667581][ T5603] Code: 28 00 00 00 75 05 48 83 c4 28 c3 e8 f1 19 00 00 90 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 [ 81.689216][ T5603] RSP: 002b:00007f94d911c168 EFLAGS: 00000246 ORIG_RAX: 0000000000000010 [ 81.697656][ T5603] RAX: ffffffffffffffda RBX: 00007f94d85ac050 RCX: 00007f94d848c0f9 [ 81.705652][ T5603] RDX: 0000000020000100 RSI: 00000000400452c8 RDI: 0000000000000006 [ 81.713649][ T5603] RBP: 00007f94d84e7b39 R08: 0000000000000000 R09: 0000000000000000 [ 81.721646][ T5603] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 81.729736][ T5603] R13: 00007ffef88f28bf R14: 00007f94d911c300 R15: 0000000000022000 [ 81.737852][ T5603] [ 82.945411][ T5087] Bluetooth: hci0: command 0x041b tx timeout 2023/03/31 08:15:28 executed programs: 4 [ 85.025177][ T5087] Bluetooth: hci0: command 0x040f tx timeout [ 87.105194][ T5087] Bluetooth: hci0: command 0x0419 tx timeout [ 89.185168][ T5087] Bluetooth: hci0: command 0x0405 tx timeout 2023/03/31 08:15:33 executed programs: 10