Warning: Permanently added '10.128.1.134' (ECDSA) to the list of known hosts. 2022/12/07 23:58:51 ignoring optional flag "sandboxArg"="0" 2022/12/07 23:58:51 parsed 1 programs 2022/12/07 23:58:51 executed programs: 0 [ 69.509978][ T4083] cgroup: Unknown subsys name 'net' [ 69.521204][ T4083] cgroup: Unknown subsys name 'rlimit' [ 70.621719][ T47] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 70.629584][ T47] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 70.637112][ T47] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 70.645983][ T47] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 70.654284][ T47] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 70.661946][ T47] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 70.670071][ T4090] Bluetooth: hci0: HCI_REQ-0x0c1a [ 70.735752][ T4090] chnl_net:caif_netlink_parms(): no params data found [ 70.773551][ T4090] bridge0: port 1(bridge_slave_0) entered blocking state [ 70.780744][ T4090] bridge0: port 1(bridge_slave_0) entered disabled state [ 70.788995][ T4090] device bridge_slave_0 entered promiscuous mode [ 70.797042][ T4090] bridge0: port 2(bridge_slave_1) entered blocking state [ 70.804354][ T4090] bridge0: port 2(bridge_slave_1) entered disabled state [ 70.812124][ T4090] device bridge_slave_1 entered promiscuous mode [ 70.833033][ T4090] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 70.843743][ T4090] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 70.865289][ T4090] team0: Port device team_slave_0 added [ 70.872424][ T4090] team0: Port device team_slave_1 added [ 70.889223][ T4090] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 70.896371][ T4090] 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. [ 70.922672][ T4090] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 70.936673][ T4090] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 70.943733][ T4090] 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. [ 70.969880][ T4090] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 70.994153][ T4090] device hsr_slave_0 entered promiscuous mode [ 71.000867][ T4090] device hsr_slave_1 entered promiscuous mode [ 71.056349][ T4090] bridge0: port 2(bridge_slave_1) entered blocking state [ 71.063725][ T4090] bridge0: port 2(bridge_slave_1) entered forwarding state [ 71.071151][ T4090] bridge0: port 1(bridge_slave_0) entered blocking state [ 71.078393][ T4090] bridge0: port 1(bridge_slave_0) entered forwarding state [ 71.129405][ T4090] 8021q: adding VLAN 0 to HW filter on device bond0 [ 71.141143][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 71.151472][ T14] bridge0: port 1(bridge_slave_0) entered disabled state [ 71.160099][ T14] bridge0: port 2(bridge_slave_1) entered disabled state [ 71.170146][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 71.180652][ T1254] ieee802154 phy0 wpan0: encryption failed: -22 [ 71.187179][ T1254] ieee802154 phy1 wpan1: encryption failed: -22 [ 71.270927][ T4090] 8021q: adding VLAN 0 to HW filter on device team0 [ 71.289650][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 71.299526][ T3013] bridge0: port 1(bridge_slave_0) entered blocking state [ 71.306600][ T3013] bridge0: port 1(bridge_slave_0) entered forwarding state [ 71.314901][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 71.324743][ T3013] bridge0: port 2(bridge_slave_1) entered blocking state [ 71.331870][ T3013] bridge0: port 2(bridge_slave_1) entered forwarding state [ 71.352981][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 71.364806][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 71.387189][ T4090] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 71.399519][ T4090] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 71.414466][ T4097] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 71.424633][ T4097] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 71.433613][ T4097] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 71.443867][ T4097] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 71.469095][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 71.476544][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 71.488590][ T4090] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 71.877411][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 71.885935][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 71.895992][ T3643] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 71.905035][ T3643] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 71.913573][ T3643] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 71.922323][ T3643] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 71.932011][ T4090] device veth0_vlan entered promiscuous mode [ 71.941854][ T4090] device veth1_vlan entered promiscuous mode [ 71.958628][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 71.966605][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 71.975007][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 71.984403][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 71.995622][ T4090] device veth0_macvtap entered promiscuous mode [ 72.004567][ T4090] device veth1_macvtap entered promiscuous mode [ 72.018864][ T4090] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 72.026232][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 72.034711][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 72.043083][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 72.051739][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 72.063860][ T4090] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 72.072094][ T3643] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 72.080822][ T3643] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 72.124154][ T11] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 72.140265][ T11] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 72.150791][ T9] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 72.151625][ T3013] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 72.159637][ T9] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 72.176471][ T3643] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 72.698225][ T47] Bluetooth: hci0: command 0x0409 tx timeout [ 73.034813][ T4111] [ 73.037157][ T4111] ====================================================== [ 73.044156][ T4111] WARNING: possible circular locking dependency detected [ 73.051151][ T4111] 6.1.0-rc8-syzkaller-00018-g479174d402bc #0 Not tainted [ 73.058164][ T4111] ------------------------------------------------------ [ 73.065240][ T4111] syz-executor.0/4111 is trying to acquire lock: [ 73.071545][ T4111] ffff888070f01130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sk_state_change+0x52/0x2f0 [ 73.083013][ T4111] [ 73.083013][ T4111] but task is already holding lock: [ 73.090363][ T4111] ffff88806f0e7128 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x276/0x470 [ 73.099309][ T4111] [ 73.099309][ T4111] which lock already depends on the new lock. [ 73.099309][ T4111] [ 73.109711][ T4111] [ 73.109711][ T4111] the existing dependency chain (in reverse order) is: [ 73.118793][ T4111] [ 73.118793][ T4111] -> #2 (&d->lock){+.+.}-{3:3}: [ 73.125964][ T4111] lock_acquire+0x1a7/0x400 [ 73.130996][ T4111] __mutex_lock_common+0x1de/0x26c0 [ 73.136803][ T4111] mutex_lock_nested+0x17/0x20 [ 73.142079][ T4111] __rfcomm_dlc_close+0x276/0x470 [ 73.147613][ T4111] rfcomm_dlc_close+0x10d/0x1c0 [ 73.153055][ T4111] __rfcomm_sock_close+0x101/0x220 [ 73.158711][ T4111] rfcomm_sock_shutdown+0xad/0x230 [ 73.164351][ T4111] rfcomm_sock_release+0x55/0x120 [ 73.169969][ T4111] sock_close+0xd7/0x260 [ 73.174803][ T4111] __fput+0x3ba/0x880 [ 73.179382][ T4111] task_work_run+0x243/0x300 [ 73.184567][ T4111] get_signal+0x1642/0x1810 [ 73.189581][ T4111] arch_do_signal_or_restart+0x8d/0x750 [ 73.195630][ T4111] exit_to_user_mode_loop+0x74/0x160 [ 73.201424][ T4111] exit_to_user_mode_prepare+0xad/0x110 [ 73.207482][ T4111] syscall_exit_to_user_mode+0x2e/0x60 [ 73.213453][ T4111] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 73.219852][ T4111] [ 73.219852][ T4111] -> #1 (rfcomm_mutex){+.+.}-{3:3}: [ 73.227225][ T4111] lock_acquire+0x1a7/0x400 [ 73.232239][ T4111] __mutex_lock_common+0x1de/0x26c0 [ 73.237944][ T4111] mutex_lock_nested+0x17/0x20 [ 73.243216][ T4111] rfcomm_dlc_open+0x25/0x50 [ 73.248314][ T4111] rfcomm_sock_connect+0x285/0x470 [ 73.254033][ T4111] __sys_connect+0x29b/0x2d0 [ 73.259136][ T4111] __x64_sys_connect+0x76/0x80 [ 73.264409][ T4111] do_syscall_64+0x2b/0x70 [ 73.269341][ T4111] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 73.275739][ T4111] [ 73.275739][ T4111] -> #0 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}: [ 73.285208][ T4111] validate_chain+0x184a/0x6470 [ 73.290564][ T4111] __lock_acquire+0x1292/0x1f60 [ 73.295922][ T4111] lock_acquire+0x1a7/0x400 [ 73.300929][ T4111] lock_sock_nested+0x44/0xf0 [ 73.306125][ T4111] rfcomm_sk_state_change+0x52/0x2f0 [ 73.311944][ T4111] __rfcomm_dlc_close+0x2bb/0x470 [ 73.317472][ T4111] rfcomm_dlc_close+0x10d/0x1c0 [ 73.322829][ T4111] __rfcomm_sock_close+0x101/0x220 [ 73.328444][ T4111] rfcomm_sock_shutdown+0xad/0x230 [ 73.334061][ T4111] rfcomm_sock_release+0x55/0x120 [ 73.339596][ T4111] sock_close+0xd7/0x260 [ 73.344346][ T4111] __fput+0x3ba/0x880 [ 73.349008][ T4111] task_work_run+0x243/0x300 [ 73.354105][ T4111] get_signal+0x1642/0x1810 [ 73.359124][ T4111] arch_do_signal_or_restart+0x8d/0x750 [ 73.365172][ T4111] exit_to_user_mode_loop+0x74/0x160 [ 73.370966][ T4111] exit_to_user_mode_prepare+0xad/0x110 [ 73.377190][ T4111] syscall_exit_to_user_mode+0x2e/0x60 [ 73.383199][ T4111] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 73.389596][ T4111] [ 73.389596][ T4111] other info that might help us debug this: [ 73.389596][ T4111] [ 73.399841][ T4111] Chain exists of: [ 73.399841][ T4111] sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM --> rfcomm_mutex --> &d->lock [ 73.399841][ T4111] [ 73.414346][ T4111] Possible unsafe locking scenario: [ 73.414346][ T4111] [ 73.421778][ T4111] CPU0 CPU1 [ 73.427209][ T4111] ---- ---- [ 73.432646][ T4111] lock(&d->lock); [ 73.436523][ T4111] lock(rfcomm_mutex); [ 73.443279][ T4111] lock(&d->lock); [ 73.449595][ T4111] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 73.455759][ T4111] [ 73.455759][ T4111] *** DEADLOCK *** [ 73.455759][ T4111] [ 73.463971][ T4111] 3 locks held by syz-executor.0/4111: [ 73.469418][ T4111] #0: ffff8880736f8210 (&sb->s_type->i_mutex_key#9){+.+.}-{3:3}, at: sock_close+0x93/0x260 [ 73.479595][ T4111] #1: ffffffff8e5df5c8 (rfcomm_mutex){+.+.}-{3:3}, at: rfcomm_dlc_close+0x32/0x1c0 [ 73.488972][ T4111] #2: ffff88806f0e7128 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x276/0x470 [ 73.498543][ T4111] [ 73.498543][ T4111] stack backtrace: [ 73.504413][ T4111] CPU: 1 PID: 4111 Comm: syz-executor.0 Not tainted 6.1.0-rc8-syzkaller-00018-g479174d402bc #0 [ 73.514804][ T4111] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 73.524964][ T4111] Call Trace: [ 73.528231][ T4111] [ 73.531241][ T4111] dump_stack_lvl+0x1e3/0x2cb [ 73.535906][ T4111] ? nf_tcp_handle_invalid+0x62e/0x62e [ 73.541364][ T4111] ? print_circular_bug+0x13e/0x1c0 [ 73.546549][ T4111] check_noncircular+0x2f9/0x3b0 [ 73.551500][ T4111] ? add_chain_block+0x850/0x850 [ 73.556485][ T4111] ? lockdep_lock+0x11d/0x2a0 [ 73.561169][ T4111] ? _find_first_zero_bit+0xe8/0x110 [ 73.566447][ T4111] validate_chain+0x184a/0x6470 [ 73.571301][ T4111] ? reacquire_held_locks+0x680/0x680 [ 73.576659][ T4111] ? register_lock_class+0xfe/0x9b0 [ 73.581842][ T4111] ? is_dynamic_key+0x1f0/0x1f0 [ 73.586681][ T4111] ? mark_lock+0x9a/0x350 [ 73.590993][ T4111] ? __lock_acquire+0x1292/0x1f60 [ 73.596008][ T4111] ? mark_lock+0x9a/0x350 [ 73.600321][ T4111] __lock_acquire+0x1292/0x1f60 [ 73.605161][ T4111] lock_acquire+0x1a7/0x400 [ 73.609650][ T4111] ? rfcomm_sk_state_change+0x52/0x2f0 [ 73.615106][ T4111] ? read_lock_is_recursive+0x10/0x10 [ 73.620918][ T4111] ? __mutex_lock_common+0x45d/0x26c0 [ 73.626280][ T4111] ? del_timer+0x340/0x3d0 [ 73.630682][ T4111] ? __rfcomm_dlc_close+0x276/0x470 [ 73.635865][ T4111] ? mutex_lock_io_nested+0x60/0x60 [ 73.641138][ T4111] lock_sock_nested+0x44/0xf0 [ 73.645848][ T4111] ? rfcomm_sk_state_change+0x52/0x2f0 [ 73.656106][ T4111] rfcomm_sk_state_change+0x52/0x2f0 [ 73.661383][ T4111] __rfcomm_dlc_close+0x2bb/0x470 [ 73.666584][ T4111] rfcomm_dlc_close+0x10d/0x1c0 [ 73.671440][ T4111] __rfcomm_sock_close+0x101/0x220 [ 73.676732][ T4111] rfcomm_sock_shutdown+0xad/0x230 [ 73.681852][ T4111] rfcomm_sock_release+0x55/0x120 [ 73.686890][ T4111] sock_close+0xd7/0x260 [ 73.691126][ T4111] ? __fput+0x3b2/0x880 [ 73.695485][ T4111] ? sock_mmap+0x90/0x90 [ 73.699712][ T4111] __fput+0x3ba/0x880 [ 73.703689][ T4111] task_work_run+0x243/0x300 [ 73.708283][ T4111] ? task_work_cancel+0x290/0x290 [ 73.713385][ T4111] get_signal+0x1642/0x1810 [ 73.717979][ T4111] ? kick_process+0xd6/0x140 [ 73.722861][ T4111] ? task_work_add+0x2e6/0x340 [ 73.727717][ T4111] ? rcu_lock_release+0x20/0x20 [ 73.732563][ T4111] ? ptrace_notify+0x340/0x340 [ 73.737321][ T4111] arch_do_signal_or_restart+0x8d/0x750 [ 73.742947][ T4111] ? __sys_connect+0x157/0x2d0 [ 73.747702][ T4111] ? get_sigframe_size+0x10/0x10 [ 73.752629][ T4111] ? exit_to_user_mode_loop+0x42/0x160 [ 73.758077][ T4111] exit_to_user_mode_loop+0x74/0x160 [ 73.763365][ T4111] exit_to_user_mode_prepare+0xad/0x110 [ 73.768897][ T4111] syscall_exit_to_user_mode+0x2e/0x60 [ 73.774435][ T4111] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 73.780314][ T4111] RIP: 0033:0x7f3257889049 [ 73.784717][ T4111] 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 [ 73.804416][ T4111] RSP: 002b:00007f3258939168 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 73.812832][ T4111] RAX: fffffffffffffffc RBX: 00007f325799bf60 RCX: 00007f3257889049 [ 73.820798][ T4111] RDX: 0000000000000080 RSI: 0000000020000000 RDI: 0000000000000004 [ 73.828811][ T4111] RBP: 00007f32578e308d R08: 0000000000000000 R09: 0000000000000000 [ 73.836768][ T4111] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 73.844841][ T4111] R13: 00007fff662458bf R14: 00007f3258939300 R15: 0000000000022000 [ 73.852806][ T4111] 2022/12/07 23:58:56 executed programs: 2 [ 74.777345][ T47] Bluetooth: hci0: command 0x041b tx timeout [ 76.298270][ T151] cfg80211: failed to load regulatory.db [ 76.857328][ T47] Bluetooth: hci0: command 0x040f tx timeout [ 78.937295][ T3634] Bluetooth: hci0: command 0x0419 tx timeout 2022/12/07 23:59:01 executed programs: 8 [ 81.017364][ T3634] Bluetooth: hci0: command 0x0405 tx timeout