Warning: Permanently added '10.128.10.31' (ECDSA) to the list of known hosts. 2022/12/28 07:33:54 ignoring optional flag "sandboxArg"="0" 2022/12/28 07:33:55 parsed 1 programs 2022/12/28 07:33:55 executed programs: 0 [ 106.613819][ T48] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 106.621988][ T48] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 106.631131][ T48] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 106.639222][ T48] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 106.647570][ T48] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 106.654905][ T48] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 106.758521][ T5539] chnl_net:caif_netlink_parms(): no params data found [ 106.812497][ T5539] bridge0: port 1(bridge_slave_0) entered blocking state [ 106.819963][ T5539] bridge0: port 1(bridge_slave_0) entered disabled state [ 106.828198][ T5539] device bridge_slave_0 entered promiscuous mode [ 106.837397][ T5539] bridge0: port 2(bridge_slave_1) entered blocking state [ 106.844648][ T5539] bridge0: port 2(bridge_slave_1) entered disabled state [ 106.853963][ T5539] device bridge_slave_1 entered promiscuous mode [ 106.878870][ T5539] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 106.890544][ T5539] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 106.919902][ T5539] team0: Port device team_slave_0 added [ 106.928528][ T5539] team0: Port device team_slave_1 added [ 106.950758][ T5539] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 106.957884][ T5539] 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. [ 106.984163][ T5539] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 106.996811][ T5539] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 107.003794][ T5539] 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. [ 107.030166][ T5539] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 107.062718][ T5539] device hsr_slave_0 entered promiscuous mode [ 107.070022][ T5539] device hsr_slave_1 entered promiscuous mode [ 107.153968][ T5539] bridge0: port 2(bridge_slave_1) entered blocking state [ 107.161418][ T5539] bridge0: port 2(bridge_slave_1) entered forwarding state [ 107.168983][ T5539] bridge0: port 1(bridge_slave_0) entered blocking state [ 107.176099][ T5539] bridge0: port 1(bridge_slave_0) entered forwarding state [ 107.225694][ T5539] 8021q: adding VLAN 0 to HW filter on device bond0 [ 107.239968][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 107.249370][ T5085] bridge0: port 1(bridge_slave_0) entered disabled state [ 107.259506][ T5085] bridge0: port 2(bridge_slave_1) entered disabled state [ 107.268308][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 107.283287][ T5539] 8021q: adding VLAN 0 to HW filter on device team0 [ 107.294958][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 107.304636][ T5085] bridge0: port 1(bridge_slave_0) entered blocking state [ 107.311838][ T5085] bridge0: port 1(bridge_slave_0) entered forwarding state [ 107.324524][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 107.333574][ T7] bridge0: port 2(bridge_slave_1) entered blocking state [ 107.340730][ T7] bridge0: port 2(bridge_slave_1) entered forwarding state [ 107.370024][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 107.382085][ T5539] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 107.393832][ T5539] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 107.403365][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 107.411488][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 107.434097][ T5539] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 107.443045][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 107.450758][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 107.976857][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_virt_wifi: link becomes ready [ 107.985560][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 108.001805][ T5539] device veth0_vlan entered promiscuous mode [ 108.009263][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_vlan: link becomes ready [ 108.018060][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 108.028510][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 108.036302][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 108.049451][ T5539] device veth1_vlan entered promiscuous mode [ 108.070914][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 108.079727][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 108.088002][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_macvtap: link becomes ready [ 108.097608][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 108.109104][ T5539] device veth0_macvtap entered promiscuous mode [ 108.121042][ T5539] device veth1_macvtap entered promiscuous mode [ 108.137598][ T5539] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 108.145323][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 108.153583][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): macsec0: link becomes ready [ 108.162711][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 108.171598][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 108.183714][ T5539] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 108.191666][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 108.200613][ T5083] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 108.266222][ T56] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 108.285406][ T56] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 108.298389][ T5085] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 108.308863][ T46] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 108.318425][ T46] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 108.328169][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 108.677716][ T48] Bluetooth: hci0: command 0x0409 tx timeout [ 109.196181][ T5560] [ 109.198632][ T5560] ====================================================== [ 109.205645][ T5560] WARNING: possible circular locking dependency detected [ 109.212658][ T5560] 6.1.0-syzkaller-12784-gc183e6c3ec34 #0 Not tainted [ 109.219327][ T5560] ------------------------------------------------------ [ 109.226336][ T5560] syz-executor.0/5560 is trying to acquire lock: [ 109.232654][ T5560] ffff88802ae8f130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sk_state_change+0x6d/0x3a0 [ 109.244207][ T5560] [ 109.244207][ T5560] but task is already holding lock: [ 109.251585][ T5560] ffff88806f4b9128 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x15d/0x890 [ 109.260500][ T5560] [ 109.260500][ T5560] which lock already depends on the new lock. [ 109.260500][ T5560] [ 109.271104][ T5560] [ 109.271104][ T5560] the existing dependency chain (in reverse order) is: [ 109.280212][ T5560] [ 109.280212][ T5560] -> #2 (&d->lock){+.+.}-{3:3}: [ 109.287360][ T5560] __mutex_lock+0x12f/0x1360 [ 109.292523][ T5560] __rfcomm_dlc_close+0x15d/0x890 [ 109.298096][ T5560] rfcomm_dlc_close+0x1e9/0x240 [ 109.303491][ T5560] __rfcomm_sock_close+0x13c/0x250 [ 109.309152][ T5560] rfcomm_sock_shutdown+0xd8/0x230 [ 109.314809][ T5560] rfcomm_sock_release+0x68/0x140 [ 109.320379][ T5560] __sock_release+0xcd/0x280 [ 109.325512][ T5560] sock_close+0x1c/0x20 [ 109.330214][ T5560] __fput+0x27c/0xa90 [ 109.334745][ T5560] task_work_run+0x16f/0x270 [ 109.339887][ T5560] get_signal+0x1c7/0x2450 [ 109.344840][ T5560] arch_do_signal_or_restart+0x79/0x5c0 [ 109.350926][ T5560] exit_to_user_mode_prepare+0x15f/0x250 [ 109.357101][ T5560] syscall_exit_to_user_mode+0x1d/0x50 [ 109.363098][ T5560] do_syscall_64+0x46/0xb0 [ 109.368064][ T5560] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 109.374513][ T5560] [ 109.374513][ T5560] -> #1 (rfcomm_mutex){+.+.}-{3:3}: [ 109.381921][ T5560] __mutex_lock+0x12f/0x1360 [ 109.387063][ T5560] rfcomm_dlc_open+0x93/0xa80 [ 109.392282][ T5560] rfcomm_sock_connect+0x329/0x450 [ 109.397935][ T5560] __sys_connect_file+0x153/0x1a0 [ 109.403512][ T5560] __sys_connect+0x165/0x1a0 [ 109.408648][ T5560] __x64_sys_connect+0x73/0xb0 [ 109.413965][ T5560] do_syscall_64+0x39/0xb0 [ 109.418928][ T5560] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 109.425564][ T5560] [ 109.425564][ T5560] -> #0 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}: [ 109.434969][ T5560] __lock_acquire+0x2a43/0x56d0 [ 109.440361][ T5560] lock_acquire+0x1e3/0x630 [ 109.445415][ T5560] lock_sock_nested+0x3a/0xf0 [ 109.450635][ T5560] rfcomm_sk_state_change+0x6d/0x3a0 [ 109.456468][ T5560] __rfcomm_dlc_close+0x1b1/0x890 [ 109.462032][ T5560] rfcomm_dlc_close+0x1e9/0x240 [ 109.467422][ T5560] __rfcomm_sock_close+0x13c/0x250 [ 109.473083][ T5560] rfcomm_sock_shutdown+0xd8/0x230 [ 109.478740][ T5560] rfcomm_sock_release+0x68/0x140 [ 109.484397][ T5560] __sock_release+0xcd/0x280 [ 109.489537][ T5560] sock_close+0x1c/0x20 [ 109.494231][ T5560] __fput+0x27c/0xa90 [ 109.498847][ T5560] task_work_run+0x16f/0x270 [ 109.504337][ T5560] get_signal+0x1c7/0x2450 [ 109.509296][ T5560] arch_do_signal_or_restart+0x79/0x5c0 [ 109.515381][ T5560] exit_to_user_mode_prepare+0x15f/0x250 [ 109.521559][ T5560] syscall_exit_to_user_mode+0x1d/0x50 [ 109.527647][ T5560] do_syscall_64+0x46/0xb0 [ 109.532618][ T5560] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 109.539068][ T5560] [ 109.539068][ T5560] other info that might help us debug this: [ 109.539068][ T5560] [ 109.549298][ T5560] Chain exists of: [ 109.549298][ T5560] sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM --> rfcomm_mutex --> &d->lock [ 109.549298][ T5560] [ 109.563245][ T5560] Possible unsafe locking scenario: [ 109.563245][ T5560] [ 109.570708][ T5560] CPU0 CPU1 [ 109.576092][ T5560] ---- ---- [ 109.581464][ T5560] lock(&d->lock); [ 109.585302][ T5560] lock(rfcomm_mutex); [ 109.592018][ T5560] lock(&d->lock); [ 109.598366][ T5560] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 109.604538][ T5560] [ 109.604538][ T5560] *** DEADLOCK *** [ 109.604538][ T5560] [ 109.612691][ T5560] 3 locks held by syz-executor.0/5560: [ 109.618160][ T5560] #0: ffff8880732f9a10 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: __sock_release+0x86/0x280 [ 109.628741][ T5560] #1: ffffffff8e3141c8 (rfcomm_mutex){+.+.}-{3:3}, at: rfcomm_dlc_close+0x33/0x240 [ 109.638272][ T5560] #2: ffff88806f4b9128 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x15d/0x890 [ 109.648463][ T5560] [ 109.648463][ T5560] stack backtrace: [ 109.654528][ T5560] CPU: 0 PID: 5560 Comm: syz-executor.0 Not tainted 6.1.0-syzkaller-12784-gc183e6c3ec34 #0 [ 109.664534][ T5560] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 109.674601][ T5560] Call Trace: [ 109.677890][ T5560] [ 109.680831][ T5560] dump_stack_lvl+0xd1/0x138 [ 109.685449][ T5560] check_noncircular+0x25f/0x2e0 [ 109.690403][ T5560] ? __lock_acquire+0x2567/0x56d0 [ 109.695454][ T5560] ? print_circular_bug+0x1e0/0x1e0 [ 109.700674][ T5560] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 109.706763][ T5560] __lock_acquire+0x2a43/0x56d0 [ 109.711641][ T5560] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 109.717647][ T5560] lock_acquire+0x1e3/0x630 [ 109.722171][ T5560] ? rfcomm_sk_state_change+0x6d/0x3a0 [ 109.727662][ T5560] ? lock_release+0x810/0x810 [ 109.732365][ T5560] ? __rfcomm_dlc_close+0x15d/0x890 [ 109.737589][ T5560] ? _raw_spin_unlock_irqrestore+0x54/0x70 [ 109.743423][ T5560] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 109.749016][ T5560] ? _raw_spin_unlock_irqrestore+0x41/0x70 [ 109.754848][ T5560] ? __timer_delete+0xe8/0x1b0 [ 109.759641][ T5560] lock_sock_nested+0x3a/0xf0 [ 109.764345][ T5560] ? rfcomm_sk_state_change+0x6d/0x3a0 [ 109.769838][ T5560] rfcomm_sk_state_change+0x6d/0x3a0 [ 109.775164][ T5560] __rfcomm_dlc_close+0x1b1/0x890 [ 109.780224][ T5560] rfcomm_dlc_close+0x1e9/0x240 [ 109.785101][ T5560] ? __sanitizer_cov_trace_switch+0x54/0x90 [ 109.791035][ T5560] __rfcomm_sock_close+0x13c/0x250 [ 109.796175][ T5560] ? lockdep_hardirqs_on+0x7d/0x100 [ 109.801415][ T5560] rfcomm_sock_shutdown+0xd8/0x230 [ 109.806560][ T5560] rfcomm_sock_release+0x68/0x140 [ 109.811614][ T5560] __sock_release+0xcd/0x280 [ 109.816234][ T5560] sock_close+0x1c/0x20 [ 109.820412][ T5560] __fput+0x27c/0xa90 [ 109.824436][ T5560] ? __sock_release+0x280/0x280 [ 109.829324][ T5560] task_work_run+0x16f/0x270 [ 109.833968][ T5560] ? task_work_cancel+0x30/0x30 [ 109.838954][ T5560] ? rfcomm_sock_connect+0x159/0x450 [ 109.844277][ T5560] get_signal+0x1c7/0x2450 [ 109.848723][ T5560] ? task_work_func_match+0x40/0x40 [ 109.853963][ T5560] ? exit_signals+0x8b0/0x8b0 [ 109.858683][ T5560] ? rfcomm_sock_connect+0x15e/0x450 [ 109.864013][ T5560] arch_do_signal_or_restart+0x79/0x5c0 [ 109.869590][ T5560] ? get_sigframe_size+0x10/0x10 [ 109.874586][ T5560] exit_to_user_mode_prepare+0x15f/0x250 [ 109.880244][ T5560] syscall_exit_to_user_mode+0x1d/0x50 [ 109.885725][ T5560] do_syscall_64+0x46/0xb0 [ 109.890172][ T5560] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 109.896118][ T5560] RIP: 0033:0x4665f9 [ 109.900033][ T5560] 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 bc ff ff ff f7 d8 64 89 01 48 [ 109.919664][ T5560] RSP: 002b:00007f2b697af188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 109.928116][ T5560] RAX: fffffffffffffffc RBX: 000000000056bf80 RCX: 00000000004665f9 [ 109.936137][ T5560] RDX: 0000000000000080 RSI: 00000000200001c0 RDI: 0000000000000004 [ 109.944123][ T5560] RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000 [ 109.952107][ T5560] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 [ 109.960092][ T5560] R13: 00007ffcbba2f2ef R14: 00007f2b697af300 R15: 0000000000022000 [ 109.968090][ T5560] [ 110.756663][ T48] Bluetooth: hci0: command 0x041b tx timeout 2022/12/28 07:34:00 executed programs: 2 [ 112.846779][ T48] Bluetooth: hci0: command 0x040f tx timeout [ 114.916633][ T48] Bluetooth: hci0: command 0x0419 tx timeout 2022/12/28 07:34:05 executed programs: 8 [ 117.006637][ T48] Bluetooth: hci0: command 0x0405 tx timeout