Warning: Permanently added '10.128.1.79' (ECDSA) to the list of known hosts. 2022/12/09 04:43:01 ignoring optional flag "sandboxArg"="0" 2022/12/09 04:43:02 parsed 1 programs 2022/12/09 04:43:02 executed programs: 0 [ 109.301113][ T4093] cgroup: Unknown subsys name 'net' [ 109.310849][ T4093] cgroup: Unknown subsys name 'rlimit' [ 110.414529][ T48] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 110.422719][ T48] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 110.430852][ T48] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 110.438958][ T48] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 110.446824][ T48] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 110.454042][ T48] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 110.531598][ T4099] chnl_net:caif_netlink_parms(): no params data found [ 110.571260][ T4099] bridge0: port 1(bridge_slave_0) entered blocking state [ 110.578929][ T4099] bridge0: port 1(bridge_slave_0) entered disabled state [ 110.587126][ T4099] device bridge_slave_0 entered promiscuous mode [ 110.594966][ T4099] bridge0: port 2(bridge_slave_1) entered blocking state [ 110.602572][ T4099] bridge0: port 2(bridge_slave_1) entered disabled state [ 110.611967][ T4099] device bridge_slave_1 entered promiscuous mode [ 110.633462][ T4099] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 110.644761][ T4099] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 110.668138][ T4099] team0: Port device team_slave_0 added [ 110.676443][ T4099] team0: Port device team_slave_1 added [ 110.694165][ T4099] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 110.701276][ T4099] 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. [ 110.727236][ T4099] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 110.739960][ T4099] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 110.746997][ T4099] 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. [ 110.773397][ T4099] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 110.799999][ T4099] device hsr_slave_0 entered promiscuous mode [ 110.808117][ T4099] device hsr_slave_1 entered promiscuous mode [ 110.870264][ T4099] bridge0: port 2(bridge_slave_1) entered blocking state [ 110.877750][ T4099] bridge0: port 2(bridge_slave_1) entered forwarding state [ 110.885547][ T4099] bridge0: port 1(bridge_slave_0) entered blocking state [ 110.892718][ T4099] bridge0: port 1(bridge_slave_0) entered forwarding state [ 110.932123][ T4099] 8021q: adding VLAN 0 to HW filter on device bond0 [ 110.945229][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 110.953968][ T14] bridge0: port 1(bridge_slave_0) entered disabled state [ 110.962153][ T14] bridge0: port 2(bridge_slave_1) entered disabled state [ 110.970318][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 110.983111][ T4099] 8021q: adding VLAN 0 to HW filter on device team0 [ 110.993838][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 111.003491][ T14] bridge0: port 1(bridge_slave_0) entered blocking state [ 111.010678][ T14] bridge0: port 1(bridge_slave_0) entered forwarding state [ 111.028733][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 111.037890][ T7] bridge0: port 2(bridge_slave_1) entered blocking state [ 111.045435][ T7] bridge0: port 2(bridge_slave_1) entered forwarding state [ 111.065480][ T4099] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 111.078404][ T4099] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 111.091780][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 111.100541][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 111.109083][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 111.117563][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 111.126718][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 111.134818][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 111.153649][ T3653] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 111.161917][ T3653] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 111.175475][ T4099] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 111.527693][ T2226] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 111.543375][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 111.551933][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 111.563145][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 111.571833][ T150] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 111.580291][ T4099] device veth0_vlan entered promiscuous mode [ 111.592920][ T4099] device veth1_vlan entered promiscuous mode [ 111.617932][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 111.625949][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 111.634515][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 111.643777][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 111.654794][ T4099] device veth0_macvtap entered promiscuous mode [ 111.664904][ T4099] device veth1_macvtap entered promiscuous mode [ 111.681297][ T4099] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 111.689139][ T2226] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 111.698066][ T2226] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 111.706058][ T2226] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 111.715050][ T2226] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 111.726985][ T4099] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 111.739019][ T3653] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 111.747728][ T3653] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 111.802219][ T11] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 111.818052][ T11] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 111.829109][ T3653] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 111.838979][ T11] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 111.848324][ T11] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 111.857742][ T3653] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 112.487424][ T3639] Bluetooth: hci0: command 0x0409 tx timeout [ 112.727170][ T4119] [ 112.729555][ T4119] ====================================================== [ 112.736569][ T4119] WARNING: possible circular locking dependency detected [ 112.743877][ T4119] 6.1.0-rc8-syzkaller-00148-g0d1409e4ff08 #0 Not tainted [ 112.750891][ T4119] ------------------------------------------------------ [ 112.757895][ T4119] syz-executor.0/4119 is trying to acquire lock: [ 112.764207][ T4119] ffff888028e24130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sk_state_change+0x52/0x2f0 [ 112.776036][ T4119] [ 112.776036][ T4119] but task is already holding lock: [ 112.783391][ T4119] ffff88806fbefd28 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x276/0x470 [ 112.792268][ T4119] [ 112.792268][ T4119] which lock already depends on the new lock. [ 112.792268][ T4119] [ 112.802674][ T4119] [ 112.802674][ T4119] the existing dependency chain (in reverse order) is: [ 112.811680][ T4119] [ 112.811680][ T4119] -> #2 (&d->lock){+.+.}-{3:3}: [ 112.818711][ T4119] lock_acquire+0x1a7/0x400 [ 112.823738][ T4119] __mutex_lock_common+0x1de/0x26c0 [ 112.829452][ T4119] mutex_lock_nested+0x17/0x20 [ 112.834730][ T4119] __rfcomm_dlc_close+0x276/0x470 [ 112.840268][ T4119] rfcomm_dlc_close+0x10d/0x1c0 [ 112.845632][ T4119] __rfcomm_sock_close+0x101/0x220 [ 112.851258][ T4119] rfcomm_sock_shutdown+0xad/0x230 [ 112.856886][ T4119] rfcomm_sock_release+0x55/0x120 [ 112.862428][ T4119] sock_close+0xd7/0x260 [ 112.867273][ T4119] __fput+0x3ba/0x880 [ 112.871787][ T4119] task_work_run+0x243/0x300 [ 112.876898][ T4119] get_signal+0x1642/0x1810 [ 112.881918][ T4119] arch_do_signal_or_restart+0x8d/0x750 [ 112.888297][ T4119] exit_to_user_mode_loop+0x74/0x160 [ 112.894141][ T4119] exit_to_user_mode_prepare+0xad/0x110 [ 112.900223][ T4119] syscall_exit_to_user_mode+0x2e/0x60 [ 112.906207][ T4119] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 112.912880][ T4119] [ 112.912880][ T4119] -> #1 (rfcomm_mutex){+.+.}-{3:3}: [ 112.920341][ T4119] lock_acquire+0x1a7/0x400 [ 112.925363][ T4119] __mutex_lock_common+0x1de/0x26c0 [ 112.931076][ T4119] mutex_lock_nested+0x17/0x20 [ 112.936441][ T4119] rfcomm_dlc_open+0x25/0x50 [ 112.941546][ T4119] rfcomm_sock_connect+0x285/0x470 [ 112.947258][ T4119] __sys_connect+0x29b/0x2d0 [ 112.952571][ T4119] __x64_sys_connect+0x76/0x80 [ 112.958245][ T4119] do_syscall_64+0x2b/0x70 [ 112.963207][ T4119] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 112.969722][ T4119] [ 112.969722][ T4119] -> #0 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}: [ 112.979118][ T4119] validate_chain+0x184a/0x6470 [ 112.984492][ T4119] __lock_acquire+0x1292/0x1f60 [ 112.989865][ T4119] lock_acquire+0x1a7/0x400 [ 112.994882][ T4119] lock_sock_nested+0x44/0xf0 [ 113.000266][ T4119] rfcomm_sk_state_change+0x52/0x2f0 [ 113.006068][ T4119] __rfcomm_dlc_close+0x2bb/0x470 [ 113.012061][ T4119] rfcomm_dlc_close+0x10d/0x1c0 [ 113.017542][ T4119] __rfcomm_sock_close+0x101/0x220 [ 113.023280][ T4119] rfcomm_sock_shutdown+0xad/0x230 [ 113.028942][ T4119] rfcomm_sock_release+0x55/0x120 [ 113.034600][ T4119] sock_close+0xd7/0x260 [ 113.039463][ T4119] __fput+0x3ba/0x880 [ 113.043993][ T4119] task_work_run+0x243/0x300 [ 113.049123][ T4119] get_signal+0x1642/0x1810 [ 113.054332][ T4119] arch_do_signal_or_restart+0x8d/0x750 [ 113.060395][ T4119] exit_to_user_mode_loop+0x74/0x160 [ 113.066197][ T4119] exit_to_user_mode_prepare+0xad/0x110 [ 113.072345][ T4119] syscall_exit_to_user_mode+0x2e/0x60 [ 113.078356][ T4119] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 113.084771][ T4119] [ 113.084771][ T4119] other info that might help us debug this: [ 113.084771][ T4119] [ 113.095275][ T4119] Chain exists of: [ 113.095275][ T4119] sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM --> rfcomm_mutex --> &d->lock [ 113.095275][ T4119] [ 113.109202][ T4119] Possible unsafe locking scenario: [ 113.109202][ T4119] [ 113.116646][ T4119] CPU0 CPU1 [ 113.121997][ T4119] ---- ---- [ 113.127523][ T4119] lock(&d->lock); [ 113.131359][ T4119] lock(rfcomm_mutex); [ 113.138029][ T4119] lock(&d->lock); [ 113.146977][ T4119] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 113.153309][ T4119] [ 113.153309][ T4119] *** DEADLOCK *** [ 113.153309][ T4119] [ 113.161534][ T4119] 3 locks held by syz-executor.0/4119: [ 113.166982][ T4119] #0: ffff888071526e10 (&sb->s_type->i_mutex_key#9){+.+.}-{3:3}, at: sock_close+0x93/0x260 [ 113.177358][ T4119] #1: ffffffff8e5df5c8 (rfcomm_mutex){+.+.}-{3:3}, at: rfcomm_dlc_close+0x32/0x1c0 [ 113.187091][ T4119] #2: ffff88806fbefd28 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x276/0x470 [ 113.197474][ T4119] [ 113.197474][ T4119] stack backtrace: [ 113.203984][ T4119] CPU: 0 PID: 4119 Comm: syz-executor.0 Not tainted 6.1.0-rc8-syzkaller-00148-g0d1409e4ff08 #0 [ 113.214494][ T4119] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 113.224659][ T4119] Call Trace: [ 113.227952][ T4119] [ 113.230901][ T4119] dump_stack_lvl+0x1e3/0x2cb [ 113.235667][ T4119] ? nf_tcp_handle_invalid+0x62e/0x62e [ 113.241567][ T4119] ? print_circular_bug+0x13e/0x1c0 [ 113.246950][ T4119] check_noncircular+0x2f9/0x3b0 [ 113.251912][ T4119] ? add_chain_block+0x850/0x850 [ 113.256859][ T4119] ? lockdep_lock+0x11d/0x2a0 [ 113.261568][ T4119] ? _find_first_zero_bit+0xe8/0x110 [ 113.267147][ T4119] validate_chain+0x184a/0x6470 [ 113.272033][ T4119] ? reacquire_held_locks+0x680/0x680 [ 113.277556][ T4119] ? register_lock_class+0xfe/0x9b0 [ 113.282835][ T4119] ? is_dynamic_key+0x1f0/0x1f0 [ 113.287767][ T4119] ? mark_lock+0x9a/0x350 [ 113.292199][ T4119] ? __lock_acquire+0x1292/0x1f60 [ 113.297463][ T4119] ? mark_lock+0x9a/0x350 [ 113.301889][ T4119] __lock_acquire+0x1292/0x1f60 [ 113.306805][ T4119] lock_acquire+0x1a7/0x400 [ 113.311520][ T4119] ? rfcomm_sk_state_change+0x52/0x2f0 [ 113.317654][ T4119] ? read_lock_is_recursive+0x10/0x10 [ 113.323168][ T4119] ? __mutex_lock_common+0x45d/0x26c0 [ 113.328568][ T4119] ? del_timer+0x340/0x3d0 [ 113.333126][ T4119] ? __rfcomm_dlc_close+0x276/0x470 [ 113.339897][ T4119] ? mutex_lock_io_nested+0x60/0x60 [ 113.345470][ T4119] lock_sock_nested+0x44/0xf0 [ 113.350249][ T4119] ? rfcomm_sk_state_change+0x52/0x2f0 [ 113.355829][ T4119] rfcomm_sk_state_change+0x52/0x2f0 [ 113.361200][ T4119] __rfcomm_dlc_close+0x2bb/0x470 [ 113.366334][ T4119] rfcomm_dlc_close+0x10d/0x1c0 [ 113.371208][ T4119] __rfcomm_sock_close+0x101/0x220 [ 113.376351][ T4119] rfcomm_sock_shutdown+0xad/0x230 [ 113.381545][ T4119] rfcomm_sock_release+0x55/0x120 [ 113.386698][ T4119] sock_close+0xd7/0x260 [ 113.390963][ T4119] ? __fput+0x3b2/0x880 [ 113.395318][ T4119] ? sock_mmap+0x90/0x90 [ 113.399686][ T4119] __fput+0x3ba/0x880 [ 113.403685][ T4119] task_work_run+0x243/0x300 [ 113.408294][ T4119] ? task_work_cancel+0x290/0x290 [ 113.413520][ T4119] get_signal+0x1642/0x1810 [ 113.418321][ T4119] ? kick_process+0xd6/0x140 [ 113.422952][ T4119] ? task_work_add+0x2e6/0x340 [ 113.427733][ T4119] ? rcu_lock_release+0x20/0x20 [ 113.432591][ T4119] ? ptrace_notify+0x340/0x340 [ 113.437384][ T4119] arch_do_signal_or_restart+0x8d/0x750 [ 113.443212][ T4119] ? __sys_connect+0x157/0x2d0 [ 113.448136][ T4119] ? get_sigframe_size+0x10/0x10 [ 113.453097][ T4119] ? exit_to_user_mode_loop+0x42/0x160 [ 113.458664][ T4119] exit_to_user_mode_loop+0x74/0x160 [ 113.463957][ T4119] exit_to_user_mode_prepare+0xad/0x110 [ 113.469676][ T4119] syscall_exit_to_user_mode+0x2e/0x60 [ 113.475220][ T4119] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 113.481107][ T4119] RIP: 0033:0x7f0542689049 [ 113.485642][ T4119] 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 [ 113.505513][ T4119] RSP: 002b:00007f0543727168 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 113.513926][ T4119] RAX: fffffffffffffffc RBX: 00007f054279bf60 RCX: 00007f0542689049 [ 113.521922][ T4119] RDX: 0000000000000080 RSI: 0000000020000000 RDI: 0000000000000004 [ 113.530257][ T4119] RBP: 00007f05426e308d R08: 0000000000000000 R09: 0000000000000000 [ 113.538247][ T4119] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 113.546323][ T4119] R13: 00007fff6f24427f R14: 00007f0543727300 R15: 0000000000022000 [ 113.554300][ T4119] 2022/12/09 04:43:07 executed programs: 2 [ 114.566283][ T3639] Bluetooth: hci0: command 0x041b tx timeout [ 116.646231][ T3639] Bluetooth: hci0: command 0x040f tx timeout [ 118.726238][ T3639] Bluetooth: hci0: command 0x0419 tx timeout 2022/12/09 04:43:12 executed programs: 8 [ 120.816216][ T3639] Bluetooth: hci0: command 0x0405 tx timeout