[ 53.673452][ T943] bridge0: port 1(bridge_slave_0) entered disabled state [ 53.695494][ T943] device veth1_macvtap left promiscuous mode [ 53.703371][ T943] device veth0_macvtap left promiscuous mode [ 53.710955][ T943] device veth1_vlan left promiscuous mode [ 53.718801][ T943] device veth0_vlan left promiscuous mode [ 53.948410][ T943] team0 (unregistering): Port device team_slave_1 removed [ 53.964747][ T943] team0 (unregistering): Port device team_slave_0 removed [ 53.977816][ T943] bond0 (unregistering): (slave bond_slave_1): Releasing backup interface [ 53.991206][ T943] bond0 (unregistering): (slave bond_slave_0): Releasing backup interface [ 54.036636][ T943] bond0 (unregistering): Released all slaves Warning: Permanently added '10.128.10.31' (ECDSA) to the list of known hosts. 2022/08/03 10:17:41 parsed 1 programs [ 66.329904][ T27] audit: type=1400 audit(1659521861.718:188): avc: denied { mounton } for pid=3997 comm="syz-executor" path="/syzcgroup/unified" dev="cgroup2" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:cgroup_t tclass=dir permissive=1 [ 66.332528][ T3997] cgroup: Unknown subsys name 'net' [ 66.365060][ T3997] cgroup: Unknown subsys name 'rlimit' 2022/08/03 10:17:41 executed programs: 0 [ 66.375461][ T27] audit: type=1400 audit(1659521861.758:189): avc: denied { mounton } for pid=3997 comm="syz-executor" path="/proc/sys/fs/binfmt_misc" dev="binfmt_misc" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:binfmt_misc_fs_t tclass=dir permissive=1 [ 66.421385][ T27] audit: type=1400 audit(1659521861.788:190): avc: denied { mount } for pid=3997 comm="syz-executor" name="/" dev="binfmt_misc" ino=1 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:binfmt_misc_fs_t tclass=filesystem permissive=1 [ 66.459003][ T27] audit: type=1400 audit(1659521861.788:191): avc: denied { create } for pid=3997 comm="syz-executor" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 66.481074][ T27] audit: type=1400 audit(1659521861.788:192): avc: denied { write } for pid=3997 comm="syz-executor" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 66.502022][ T27] audit: type=1400 audit(1659521861.788:193): avc: denied { read } for pid=3997 comm="syz-executor" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=netlink_generic_socket permissive=1 [ 66.522895][ T27] audit: type=1400 audit(1659521861.838:194): avc: denied { getattr } for pid=4000 comm="dhcpcd-run-hook" path="/run/dhcpcd/hook-state/resolv.conf/eth0.dhcp" dev="tmpfs" ino=1444 scontext=system_u:system_r:dhcpc_t tcontext=system_u:object_r:tmpfs_t tclass=file permissive=1 [ 66.549668][ T27] audit: type=1400 audit(1659521861.858:195): avc: denied { create } for pid=4007 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=bluetooth_socket permissive=1 [ 66.570466][ T27] audit: type=1400 audit(1659521861.888:196): avc: denied { read } for pid=4008 comm="sed" name="eth0.dhcp" dev="tmpfs" ino=1444 scontext=system_u:system_r:dhcpc_t tcontext=system_u:object_r:tmpfs_t tclass=file permissive=1 [ 66.593227][ T27] audit: type=1400 audit(1659521861.888:197): avc: denied { open } for pid=4008 comm="sed" path="/run/dhcpcd/hook-state/resolv.conf/eth0.dhcp" dev="tmpfs" ino=1444 scontext=system_u:system_r:dhcpc_t tcontext=system_u:object_r:tmpfs_t tclass=file permissive=1 [ 69.616273][ T3616] Bluetooth: hci0: Opcode 0x c03 failed: -110 [ 71.140231][ T141] cfg80211: failed to load regulatory.db [ 73.776155][ T3616] Bluetooth: hci0: Opcode 0x c03 failed: -110 [ 75.861324][ T27] kauditd_printk_skb: 4 callbacks suppressed [ 75.861333][ T27] audit: type=1400 audit(1659521871.248:202): avc: denied { ioctl } for pid=4075 comm="syz-executor.0" path="socket:[29746]" dev="sockfs" ino=29746 ioctlcmd=0x48c9 scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=bluetooth_socket permissive=1 [ 75.861482][ T47] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 75.900696][ T47] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 75.908559][ T47] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 75.917178][ T47] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 75.924709][ T47] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 75.932220][ T47] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 75.946513][ T27] audit: type=1400 audit(1659521871.328:203): avc: denied { read } for pid=4075 comm="syz-executor.0" dev="nsfs" ino=4026531840 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 [ 75.968310][ T27] audit: type=1400 audit(1659521871.328:204): avc: denied { open } for pid=4075 comm="syz-executor.0" path="net:[4026531840]" dev="nsfs" ino=4026531840 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:nsfs_t tclass=file permissive=1 [ 75.992563][ T27] audit: type=1400 audit(1659521871.328:205): avc: denied { mounton } for pid=4075 comm="syz-executor.0" path="/" dev="sda1" ino=2 scontext=root:sysadm_r:sysadm_t tcontext=system_u:object_r:root_t tclass=dir permissive=1 [ 76.046905][ T4075] chnl_net:caif_netlink_parms(): no params data found [ 76.083622][ T4075] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.090920][ T4075] bridge0: port 1(bridge_slave_0) entered disabled state [ 76.099176][ T4075] device bridge_slave_0 entered promiscuous mode [ 76.107194][ T4075] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.114464][ T4075] bridge0: port 2(bridge_slave_1) entered disabled state [ 76.123003][ T4075] device bridge_slave_1 entered promiscuous mode [ 76.141983][ T4075] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 76.153710][ T4075] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 76.174740][ T4075] team0: Port device team_slave_0 added [ 76.182040][ T4075] team0: Port device team_slave_1 added [ 76.198707][ T4075] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 76.205705][ T4075] 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. [ 76.232250][ T4075] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 76.245432][ T4075] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 76.252597][ T4075] 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. [ 76.279042][ T4075] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 76.304597][ T4075] device hsr_slave_0 entered promiscuous mode [ 76.311414][ T4075] device hsr_slave_1 entered promiscuous mode [ 76.369090][ T4075] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.376293][ T4075] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.383708][ T4075] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.390812][ T4075] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.425337][ T4075] 8021q: adding VLAN 0 to HW filter on device bond0 [ 76.437362][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 76.445143][ T143] bridge0: port 1(bridge_slave_0) entered disabled state [ 76.453651][ T143] bridge0: port 2(bridge_slave_1) entered disabled state [ 76.461659][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 76.473388][ T4075] 8021q: adding VLAN 0 to HW filter on device team0 [ 76.483644][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 76.492166][ T143] bridge0: port 1(bridge_slave_0) entered blocking state [ 76.499458][ T143] bridge0: port 1(bridge_slave_0) entered forwarding state [ 76.510284][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 76.519438][ T141] bridge0: port 2(bridge_slave_1) entered blocking state [ 76.526522][ T141] bridge0: port 2(bridge_slave_1) entered forwarding state [ 76.548904][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 76.557467][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 76.565749][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 76.574196][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 76.583212][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 76.594240][ T4075] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 76.608585][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 76.616975][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 76.628499][ T4075] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 76.798286][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 76.807338][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 76.815423][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 76.823513][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 76.833567][ T4075] device veth0_vlan entered promiscuous mode [ 76.843789][ T4075] device veth1_vlan entered promiscuous mode [ 76.861378][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 76.869484][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 76.877649][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 76.888682][ T4075] device veth0_macvtap entered promiscuous mode [ 76.897548][ T4075] device veth1_macvtap entered promiscuous mode [ 76.912312][ T4075] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 76.920204][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 76.930418][ T141] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 76.941540][ T4075] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 76.949129][ T143] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 76.996985][ T11] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 77.004934][ T11] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 77.027662][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 77.041162][ T943] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 77.049104][ T943] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 77.059297][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 77.071579][ T27] audit: type=1400 audit(1659521872.458:206): avc: denied { mounton } for pid=4075 comm="syz-executor.0" path="/dev/binderfs" dev="devtmpfs" ino=2313 scontext=root:sysadm_r:sysadm_t tcontext=root:object_r:device_t tclass=dir permissive=1 [ 77.127619][ T27] audit: type=1400 audit(1659521872.508:207): avc: denied { write } for pid=4093 comm="syz-executor.0" scontext=root:sysadm_r:sysadm_t tcontext=root:sysadm_r:sysadm_t tclass=rxrpc_socket permissive=1 [ 77.958375][ T4094] [ 77.960786][ T4094] ===================================== [ 77.966356][ T4094] WARNING: bad unlock balance detected! [ 77.971970][ T4094] 5.19.0-syzkaller #0 Not tainted [ 77.977151][ T4094] ------------------------------------- [ 77.982668][ T4094] syz-executor.0/4094 is trying to release lock (&call->user_mutex) at: [ 77.990969][ T4094] [] rxrpc_do_sendmsg+0x851/0x1110 [ 77.997705][ T4094] but there are no more locks to release! [ 78.003388][ T4094] [ 78.003388][ T4094] other info that might help us debug this: [ 78.011418][ T4094] no locks held by syz-executor.0/4094. [ 78.016936][ T4094] [ 78.016936][ T4094] stack backtrace: [ 78.022808][ T4094] CPU: 1 PID: 4094 Comm: syz-executor.0 Not tainted 5.19.0-syzkaller #0 [ 78.031192][ T4094] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 07/22/2022 [ 78.041223][ T4094] Call Trace: [ 78.044507][ T4094] [ 78.047420][ T4094] dump_stack_lvl+0x57/0x7d [ 78.051902][ T4094] lock_release.cold+0x49/0x4e [ 78.056771][ T4094] ? rxrpc_do_sendmsg+0x851/0x1110 [ 78.061879][ T4094] ? lock_downgrade+0x6e0/0x6e0 [ 78.066704][ T4094] ? trace_rxrpc_transmit+0x1b0/0x1b0 [ 78.072047][ T4094] __mutex_unlock_slowpath+0x99/0x5e0 [ 78.077413][ T4094] ? wait_for_completion_io_timeout+0x20/0x20 [ 78.083453][ T4094] ? wake_up_q+0xf0/0xf0 [ 78.087771][ T4094] ? rcu_read_lock_sched_held+0x3a/0x70 [ 78.093316][ T4094] rxrpc_do_sendmsg+0x851/0x1110 [ 78.098236][ T4094] ? rxrpc_kernel_send_data+0x350/0x350 [ 78.103752][ T4094] ? rcu_read_lock_sched_held+0x3a/0x70 [ 78.109282][ T4094] ? rxrpc_lookup_local+0x36f/0x10e0 [ 78.114543][ T4094] ? rxrpc_sendmsg+0x2f7/0x5d0 [ 78.119366][ T4094] ? rxrpc_sock_destructor+0x120/0x120 [ 78.124793][ T4094] sock_sendmsg+0xab/0xe0 [ 78.129105][ T4094] ____sys_sendmsg+0x5c2/0x7a0 [ 78.133839][ T4094] ? kernel_sendmsg+0x30/0x30 [ 78.138485][ T4094] ? __copy_msghdr+0x440/0x440 [ 78.143229][ T4094] ___sys_sendmsg+0xdb/0x160 [ 78.147787][ T4094] ? do_recvmmsg+0x560/0x560 [ 78.152363][ T4094] ? __fget_files+0x1a7/0x3a0 [ 78.157014][ T4094] ? lock_downgrade+0x6e0/0x6e0 [ 78.161836][ T4094] ? lockdep_hardirqs_on_prepare+0x400/0x400 [ 78.167789][ T4094] ? __fget_light+0xb9/0x210 [ 78.172355][ T4094] __sys_sendmsg+0xc3/0x160 [ 78.176841][ T4094] ? __sys_sendmsg_sock+0x10/0x10 [ 78.181852][ T4094] ? lock_downgrade+0x6e0/0x6e0 [ 78.186695][ T4094] ? lockdep_hardirqs_on_prepare+0x17b/0x400 [ 78.192666][ T4094] ? syscall_enter_from_user_mode+0x22/0xb0 [ 78.198548][ T4094] ? lockdep_hardirqs_on+0x79/0x100 [ 78.203726][ T4094] do_syscall_64+0x35/0xb0 [ 78.208203][ T4094] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 78.214074][ T4094] RIP: 0033:0x7f552b689109 [ 78.218460][ T4094] 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.238123][ T4094] RSP: 002b:00007f552c77d168 EFLAGS: 00000246 ORIG_RAX: 000000000000002e [ 78.246506][ T4094] RAX: ffffffffffffffda RBX: 00007f552b79bf60 RCX: 00007f552b689109 2022/08/03 10:17:53 executed programs: 1 [ 78.254540][ T4094] RDX: 0000000000000000 RSI: 0000000020000000 RDI: 0000000000000003 [ 78.262570][ T4094] RBP: 00007f552b6e305d R08: 0000000000000000 R09: 0000000000000000 [ 78.270515][ T4094] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 78.278544][ T4094] R13: 00007ffce59973ef R14: 00007f552c77d300 R15: 0000000000022000 [ 78.286588][ T4094] [ 78.290058][ T14] Bluetooth: hci0: command 0x0409 tx timeout [ 80.336670][ T141] Bluetooth: hci0: command 0x041b tx timeout [ 82.416143][ T141] Bluetooth: hci0: command 0x040f tx timeout 2022/08/03 10:17:58 executed programs: 7 [ 84.496121][ T14] Bluetooth: hci0: command 0x0419 tx timeout