Warning: Permanently added '10.128.1.44' (ECDSA) to the list of known hosts. 2022/12/28 03:38:40 ignoring optional flag "sandboxArg"="0" 2022/12/28 03:38:40 parsed 1 programs 2022/12/28 03:38:40 executed programs: 0 [ 76.197547][ T7] cfg80211: failed to load regulatory.db [ 77.324698][ T48] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 77.333495][ T48] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 77.341477][ T48] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 77.349938][ T48] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 77.357519][ T48] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 77.365925][ T48] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 77.467752][ T5485] chnl_net:caif_netlink_parms(): no params data found [ 77.503547][ T5485] bridge0: port 1(bridge_slave_0) entered blocking state [ 77.510899][ T5485] bridge0: port 1(bridge_slave_0) entered disabled state [ 77.518800][ T5485] device bridge_slave_0 entered promiscuous mode [ 77.527304][ T5485] bridge0: port 2(bridge_slave_1) entered blocking state [ 77.534390][ T5485] bridge0: port 2(bridge_slave_1) entered disabled state [ 77.542323][ T5485] device bridge_slave_1 entered promiscuous mode [ 77.561715][ T5485] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 77.572719][ T5485] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 77.594003][ T5485] team0: Port device team_slave_0 added [ 77.601469][ T5485] team0: Port device team_slave_1 added [ 77.619155][ T5485] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 77.626410][ T5485] 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. [ 77.652556][ T5485] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 77.664427][ T5485] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 77.672420][ T5485] 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. [ 77.698579][ T5485] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 77.723690][ T5485] device hsr_slave_0 entered promiscuous mode [ 77.730362][ T5485] device hsr_slave_1 entered promiscuous mode [ 77.784909][ T5485] bridge0: port 2(bridge_slave_1) entered blocking state [ 77.792016][ T5485] bridge0: port 2(bridge_slave_1) entered forwarding state [ 77.799795][ T5485] bridge0: port 1(bridge_slave_0) entered blocking state [ 77.806909][ T5485] bridge0: port 1(bridge_slave_0) entered forwarding state [ 77.851095][ T5485] 8021q: adding VLAN 0 to HW filter on device bond0 [ 77.861903][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 77.870806][ T898] bridge0: port 1(bridge_slave_0) entered disabled state [ 77.878844][ T898] bridge0: port 2(bridge_slave_1) entered disabled state [ 77.887927][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 77.901134][ T5485] 8021q: adding VLAN 0 to HW filter on device team0 [ 77.911508][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 77.920604][ T898] bridge0: port 1(bridge_slave_0) entered blocking state [ 77.927686][ T898] bridge0: port 1(bridge_slave_0) entered forwarding state [ 77.946117][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 77.954792][ T898] bridge0: port 2(bridge_slave_1) entered blocking state [ 77.961925][ T898] bridge0: port 2(bridge_slave_1) entered forwarding state [ 77.972602][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 77.986112][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 77.998717][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 78.009292][ T5485] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 78.024867][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 78.032446][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 78.043674][ T5485] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 78.365447][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 78.374541][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 78.382987][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 78.390925][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 78.400784][ T5485] device veth0_vlan entered promiscuous mode [ 78.412293][ T5485] device veth1_vlan entered promiscuous mode [ 78.429372][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 78.437620][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 78.447813][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 78.457665][ T5485] device veth0_macvtap entered promiscuous mode [ 78.465239][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 78.474878][ T5485] device veth1_macvtap entered promiscuous mode [ 78.488925][ T5485] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 78.496894][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 78.505739][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 78.520489][ T5485] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 78.529904][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 78.539065][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 78.585632][ T2839] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 78.594488][ T2839] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 78.607158][ T898] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 78.622641][ T9] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 78.630676][ T9] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 78.639958][ T7] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready [ 79.396781][ T4389] Bluetooth: hci0: command 0x0409 tx timeout [ 79.500527][ T5551] [ 79.502880][ T5551] ====================================================== [ 79.509881][ T5551] WARNING: possible circular locking dependency detected [ 79.516884][ T5551] 6.1.0-syzkaller-12784-gc183e6c3ec34 #0 Not tainted [ 79.523530][ T5551] ------------------------------------------------------ [ 79.530519][ T5551] syz-executor.0/5551 is trying to acquire lock: [ 79.536919][ T5551] ffff88807637f130 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}, at: rfcomm_sk_state_change+0x6d/0x3a0 [ 79.548404][ T5551] [ 79.548404][ T5551] but task is already holding lock: [ 79.555749][ T5551] ffff88807d280d28 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x15d/0x890 [ 79.564617][ T5551] [ 79.564617][ T5551] which lock already depends on the new lock. [ 79.564617][ T5551] [ 79.575017][ T5551] [ 79.575017][ T5551] the existing dependency chain (in reverse order) is: [ 79.584043][ T5551] [ 79.584043][ T5551] -> #2 (&d->lock){+.+.}-{3:3}: [ 79.591098][ T5551] __mutex_lock+0x12f/0x1360 [ 79.596219][ T5551] __rfcomm_dlc_close+0x15d/0x890 [ 79.601763][ T5551] rfcomm_dlc_close+0x1e9/0x240 [ 79.607130][ T5551] __rfcomm_sock_close+0x13c/0x250 [ 79.612758][ T5551] rfcomm_sock_shutdown+0xd8/0x230 [ 79.618388][ T5551] rfcomm_sock_release+0x68/0x140 [ 79.623927][ T5551] __sock_release+0xcd/0x280 [ 79.629031][ T5551] sock_close+0x1c/0x20 [ 79.633704][ T5551] __fput+0x27c/0xa90 [ 79.638219][ T5551] task_work_run+0x16f/0x270 [ 79.643351][ T5551] get_signal+0x1c7/0x2450 [ 79.648294][ T5551] arch_do_signal_or_restart+0x79/0x5c0 [ 79.654358][ T5551] exit_to_user_mode_prepare+0x15f/0x250 [ 79.660516][ T5551] syscall_exit_to_user_mode+0x1d/0x50 [ 79.666501][ T5551] do_syscall_64+0x46/0xb0 [ 79.671443][ T5551] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 79.677866][ T5551] [ 79.677866][ T5551] -> #1 (rfcomm_mutex){+.+.}-{3:3}: [ 79.685245][ T5551] __mutex_lock+0x12f/0x1360 [ 79.690355][ T5551] rfcomm_dlc_open+0x93/0xa80 [ 79.695553][ T5551] rfcomm_sock_connect+0x329/0x450 [ 79.701191][ T5551] __sys_connect_file+0x153/0x1a0 [ 79.706750][ T5551] __sys_connect+0x165/0x1a0 [ 79.711890][ T5551] __x64_sys_connect+0x73/0xb0 [ 79.717195][ T5551] do_syscall_64+0x39/0xb0 [ 79.722142][ T5551] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 79.728572][ T5551] [ 79.728572][ T5551] -> #0 (sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM){+.+.}-{0:0}: [ 79.737950][ T5551] __lock_acquire+0x2a43/0x56d0 [ 79.743333][ T5551] lock_acquire+0x1e3/0x630 [ 79.748361][ T5551] lock_sock_nested+0x3a/0xf0 [ 79.753579][ T5551] rfcomm_sk_state_change+0x6d/0x3a0 [ 79.759397][ T5551] __rfcomm_dlc_close+0x1b1/0x890 [ 79.764939][ T5551] rfcomm_dlc_close+0x1e9/0x240 [ 79.770313][ T5551] __rfcomm_sock_close+0x13c/0x250 [ 79.776145][ T5551] rfcomm_sock_shutdown+0xd8/0x230 [ 79.781785][ T5551] rfcomm_sock_release+0x68/0x140 [ 79.787325][ T5551] __sock_release+0xcd/0x280 [ 79.792437][ T5551] sock_close+0x1c/0x20 [ 79.797112][ T5551] __fput+0x27c/0xa90 [ 79.801613][ T5551] task_work_run+0x16f/0x270 [ 79.806723][ T5551] get_signal+0x1c7/0x2450 [ 79.811655][ T5551] arch_do_signal_or_restart+0x79/0x5c0 [ 79.817802][ T5551] exit_to_user_mode_prepare+0x15f/0x250 [ 79.823969][ T5551] syscall_exit_to_user_mode+0x1d/0x50 [ 79.829942][ T5551] do_syscall_64+0x46/0xb0 [ 79.834872][ T5551] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 79.841291][ T5551] [ 79.841291][ T5551] other info that might help us debug this: [ 79.841291][ T5551] [ 79.851503][ T5551] Chain exists of: [ 79.851503][ T5551] sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM --> rfcomm_mutex --> &d->lock [ 79.851503][ T5551] [ 79.865399][ T5551] Possible unsafe locking scenario: [ 79.865399][ T5551] [ 79.872830][ T5551] CPU0 CPU1 [ 79.878179][ T5551] ---- ---- [ 79.883528][ T5551] lock(&d->lock); [ 79.887327][ T5551] lock(rfcomm_mutex); [ 79.893987][ T5551] lock(&d->lock); [ 79.900388][ T5551] lock(sk_lock-AF_BLUETOOTH-BTPROTO_RFCOMM); [ 79.906535][ T5551] [ 79.906535][ T5551] *** DEADLOCK *** [ 79.906535][ T5551] [ 79.914665][ T5551] 3 locks held by syz-executor.0/5551: [ 79.920107][ T5551] #0: ffff8880768bb210 (&sb->s_type->i_mutex_key#10){+.+.}-{3:3}, at: __sock_release+0x86/0x280 [ 79.930638][ T5551] #1: ffffffff8e3141c8 (rfcomm_mutex){+.+.}-{3:3}, at: rfcomm_dlc_close+0x33/0x240 [ 79.940047][ T5551] #2: ffff88807d280d28 (&d->lock){+.+.}-{3:3}, at: __rfcomm_dlc_close+0x15d/0x890 [ 79.949381][ T5551] [ 79.949381][ T5551] stack backtrace: [ 79.955258][ T5551] CPU: 1 PID: 5551 Comm: syz-executor.0 Not tainted 6.1.0-syzkaller-12784-gc183e6c3ec34 #0 [ 79.965246][ T5551] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 10/26/2022 [ 79.975301][ T5551] Call Trace: [ 79.978584][ T5551] [ 79.981513][ T5551] dump_stack_lvl+0xd1/0x138 [ 79.986112][ T5551] check_noncircular+0x25f/0x2e0 [ 79.991048][ T5551] ? __lock_acquire+0x2567/0x56d0 [ 79.996067][ T5551] ? print_circular_bug+0x1e0/0x1e0 [ 80.001262][ T5551] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 80.007240][ T5551] __lock_acquire+0x2a43/0x56d0 [ 80.012085][ T5551] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 80.018060][ T5551] lock_acquire+0x1e3/0x630 [ 80.022553][ T5551] ? rfcomm_sk_state_change+0x6d/0x3a0 [ 80.028024][ T5551] ? lock_release+0x810/0x810 [ 80.032692][ T5551] ? __rfcomm_dlc_close+0x15d/0x890 [ 80.037882][ T5551] ? _raw_spin_unlock_irqrestore+0x54/0x70 [ 80.043683][ T5551] ? mutex_lock_io_nested+0x11a0/0x11a0 [ 80.049245][ T5551] ? _raw_spin_unlock_irqrestore+0x41/0x70 [ 80.055070][ T5551] ? __timer_delete+0xe8/0x1b0 [ 80.059857][ T5551] lock_sock_nested+0x3a/0xf0 [ 80.064547][ T5551] ? rfcomm_sk_state_change+0x6d/0x3a0 [ 80.070013][ T5551] rfcomm_sk_state_change+0x6d/0x3a0 [ 80.075306][ T5551] __rfcomm_dlc_close+0x1b1/0x890 [ 80.080332][ T5551] rfcomm_dlc_close+0x1e9/0x240 [ 80.085179][ T5551] ? __sanitizer_cov_trace_switch+0x54/0x90 [ 80.091075][ T5551] __rfcomm_sock_close+0x13c/0x250 [ 80.096182][ T5551] ? lockdep_hardirqs_on+0x7d/0x100 [ 80.101385][ T5551] rfcomm_sock_shutdown+0xd8/0x230 [ 80.106493][ T5551] rfcomm_sock_release+0x68/0x140 [ 80.111515][ T5551] __sock_release+0xcd/0x280 [ 80.116100][ T5551] sock_close+0x1c/0x20 [ 80.120249][ T5551] __fput+0x27c/0xa90 [ 80.124224][ T5551] ? __sock_release+0x280/0x280 [ 80.129073][ T5551] task_work_run+0x16f/0x270 [ 80.133667][ T5551] ? task_work_cancel+0x30/0x30 [ 80.138515][ T5551] ? rfcomm_sock_connect+0x159/0x450 [ 80.143798][ T5551] get_signal+0x1c7/0x2450 [ 80.148208][ T5551] ? task_work_func_match+0x40/0x40 [ 80.153403][ T5551] ? exit_signals+0x8b0/0x8b0 [ 80.158071][ T5551] ? rfcomm_sock_connect+0x15e/0x450 [ 80.163354][ T5551] arch_do_signal_or_restart+0x79/0x5c0 [ 80.168912][ T5551] ? get_sigframe_size+0x10/0x10 [ 80.173886][ T5551] exit_to_user_mode_prepare+0x15f/0x250 [ 80.179530][ T5551] syscall_exit_to_user_mode+0x1d/0x50 [ 80.184992][ T5551] do_syscall_64+0x46/0xb0 [ 80.189421][ T5551] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 80.195335][ T5551] RIP: 0033:0x4665f9 [ 80.199227][ T5551] 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 [ 80.219114][ T5551] RSP: 002b:00007fc9a9b94188 EFLAGS: 00000246 ORIG_RAX: 000000000000002a [ 80.227531][ T5551] RAX: fffffffffffffffc RBX: 000000000056bf80 RCX: 00000000004665f9 [ 80.235503][ T5551] RDX: 0000000000000080 RSI: 0000000020000000 RDI: 0000000000000004 [ 80.243471][ T5551] RBP: 00000000004bfcc4 R08: 0000000000000000 R09: 0000000000000000 [ 80.251442][ T5551] R10: 0000000000000000 R11: 0000000000000246 R12: 000000000056bf80 [ 80.259415][ T5551] R13: 00007fffcf7864df R14: 00007fc9a9b94300 R15: 0000000000022000 [ 80.267393][ T5551] [ 81.475114][ T4389] Bluetooth: hci0: command 0x041b tx timeout 2022/12/28 03:38:46 executed programs: 3 [ 83.555184][ T4389] Bluetooth: hci0: command 0x040f tx timeout [ 85.645099][ T4389] Bluetooth: hci0: command 0x0419 tx timeout 2022/12/28 03:38:51 executed programs: 9 [ 87.715151][ T4389] Bluetooth: hci0: command 0x0405 tx timeout