Warning: Permanently added '10.128.15.222' (ECDSA) to the list of known hosts. 2023/02/24 05:17:02 fuzzer started 2023/02/24 05:17:02 connecting to host at 10.128.0.169:39839 2023/02/24 05:17:02 checking machine... 2023/02/24 05:17:02 checking revisions... 2023/02/24 05:17:03 testing simple program... syzkaller login: [ 52.615707][ T5077] cgroup: Unknown subsys name 'net' [ 52.746379][ T5077] cgroup: Unknown subsys name 'rlimit' [ 52.846520][ T5076] memfd_create() without MFD_EXEC nor MFD_NOEXEC_SEAL, pid=5076 'syz-fuzzer' [ 52.958390][ T5080] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 52.966438][ T5080] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 52.974426][ T5080] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 52.982792][ T5080] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 52.990770][ T5080] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 52.998017][ T5080] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 53.107269][ T5079] chnl_net:caif_netlink_parms(): no params data found [ 53.146669][ T5079] bridge0: port 1(bridge_slave_0) entered blocking state [ 53.155197][ T5079] bridge0: port 1(bridge_slave_0) entered disabled state [ 53.162717][ T5079] bridge_slave_0: entered allmulticast mode [ 53.169962][ T5079] bridge_slave_0: entered promiscuous mode [ 53.178216][ T5079] bridge0: port 2(bridge_slave_1) entered blocking state [ 53.185793][ T5079] bridge0: port 2(bridge_slave_1) entered disabled state [ 53.193817][ T5079] bridge_slave_1: entered allmulticast mode [ 53.200608][ T5079] bridge_slave_1: entered promiscuous mode [ 53.220145][ T5079] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 53.231627][ T5079] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 53.253546][ T5079] team0: Port device team_slave_0 added [ 53.260735][ T5079] team0: Port device team_slave_1 added [ 53.277635][ T5079] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 53.285362][ T5079] 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. [ 53.311907][ T5079] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 53.325145][ T5079] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 53.332215][ T5079] 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. [ 53.358522][ T5079] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 53.387354][ T5079] hsr_slave_0: entered promiscuous mode [ 53.394499][ T5079] hsr_slave_1: entered promiscuous mode [ 53.469253][ T5079] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 53.479581][ T5079] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 53.488943][ T5079] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 53.497904][ T5079] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 53.518220][ T5079] bridge0: port 2(bridge_slave_1) entered blocking state [ 53.525465][ T5079] bridge0: port 2(bridge_slave_1) entered forwarding state [ 53.533390][ T5079] bridge0: port 1(bridge_slave_0) entered blocking state [ 53.540632][ T5079] bridge0: port 1(bridge_slave_0) entered forwarding state [ 53.587014][ T5079] 8021q: adding VLAN 0 to HW filter on device bond0 [ 53.600322][ T897] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 53.610986][ T897] bridge0: port 1(bridge_slave_0) entered disabled state [ 53.620622][ T897] bridge0: port 2(bridge_slave_1) entered disabled state [ 53.628576][ T897] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 53.642852][ T5079] 8021q: adding VLAN 0 to HW filter on device team0 [ 53.653977][ T897] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 53.663143][ T897] bridge0: port 1(bridge_slave_0) entered blocking state [ 53.670526][ T897] bridge0: port 1(bridge_slave_0) entered forwarding state [ 53.690187][ T897] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 53.698612][ T897] bridge0: port 2(bridge_slave_1) entered blocking state [ 53.705780][ T897] bridge0: port 2(bridge_slave_1) entered forwarding state [ 53.714522][ T897] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 53.732935][ T5079] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 53.745841][ T5079] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 53.759451][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 53.767515][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 53.776266][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 53.785284][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 53.797830][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 53.911281][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 53.920597][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 53.931058][ T5079] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 53.949505][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 53.970523][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 53.979874][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 53.988026][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 53.998514][ T5079] veth0_vlan: entered promiscuous mode [ 54.012731][ T5079] veth1_vlan: entered promiscuous mode [ 54.032726][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 54.041499][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 54.050811][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 54.061129][ T5079] veth0_macvtap: entered promiscuous mode [ 54.072799][ T5079] veth1_macvtap: entered promiscuous mode [ 54.081136][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 54.098073][ T5079] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 54.106794][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 54.116310][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 54.128670][ T5079] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 54.138580][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 54.148102][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 54.167072][ T5079] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.176794][ T5079] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.186342][ T5079] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.195583][ T5079] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 54.255426][ T41] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 54.272527][ T41] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 54.282081][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 54.292574][ T11] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 54.302119][ T11] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 54.313305][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready 2023/02/24 05:17:04 building call list... [ 54.483684][ T5079] [ 54.486136][ T5079] ====================================================== [ 54.493677][ T5079] WARNING: possible circular locking dependency detected [ 54.500703][ T5079] 6.2.0-next-20230224-syzkaller #0 Not tainted [ 54.507053][ T5079] ------------------------------------------------------ [ 54.514073][ T5079] syz-executor.0/5079 is trying to acquire lock: [ 54.520399][ T5079] ffff888022388880 ((work_completion)(&hdev->cmd_sync_work)){+.+.}-{0:0}, at: __flush_work+0xdd/0xb60 [ 54.531501][ T5079] [ 54.531501][ T5079] but task is already holding lock: [ 54.538877][ T5079] ffff888022388920 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}, at: hci_cmd_sync_clear+0x3c/0x2a0 [ 54.549180][ T5079] [ 54.549180][ T5079] which lock already depends on the new lock. [ 54.549180][ T5079] [ 54.559602][ T5079] [ 54.559602][ T5079] the existing dependency chain (in reverse order) is: [ 54.568621][ T5079] [ 54.568621][ T5079] -> #1 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}: [ 54.577160][ T5079] __mutex_lock+0x12f/0x1350 [ 54.582474][ T5079] hci_cmd_sync_work+0x26f/0x450 [ 54.587960][ T5079] process_one_work+0x9bf/0x1820 [ 54.593428][ T5079] worker_thread+0x669/0x1090 [ 54.598708][ T5079] kthread+0x2e8/0x3a0 [ 54.603300][ T5079] ret_from_fork+0x1f/0x30 [ 54.608291][ T5079] [ 54.608291][ T5079] -> #0 ((work_completion)(&hdev->cmd_sync_work)){+.+.}-{0:0}: [ 54.618104][ T5079] __lock_acquire+0x2ec7/0x5d40 [ 54.623472][ T5079] lock_acquire.part.0+0x11a/0x370 [ 54.629096][ T5079] __flush_work+0x109/0xb60 [ 54.634124][ T5079] __cancel_work_timer+0x3f9/0x570 [ 54.639755][ T5079] hci_cmd_sync_clear+0x48/0x2a0 [ 54.645210][ T5079] hci_unregister_dev+0x16b/0x580 [ 54.650752][ T5079] vhci_release+0x80/0xf0 [ 54.655605][ T5079] __fput+0x27c/0xa90 [ 54.660288][ T5079] task_work_run+0x16f/0x270 [ 54.665412][ T5079] do_exit+0xb42/0x2b60 [ 54.670089][ T5079] do_group_exit+0xd4/0x2a0 [ 54.675105][ T5079] get_signal+0x2315/0x25b0 [ 54.680129][ T5079] arch_do_signal_or_restart+0x79/0x5c0 [ 54.686368][ T5079] exit_to_user_mode_prepare+0x15f/0x250 [ 54.692614][ T5079] syscall_exit_to_user_mode+0x1d/0x50 [ 54.698593][ T5079] do_syscall_64+0x46/0xb0 [ 54.703523][ T5079] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 54.709929][ T5079] [ 54.709929][ T5079] other info that might help us debug this: [ 54.709929][ T5079] [ 54.720144][ T5079] Possible unsafe locking scenario: [ 54.720144][ T5079] [ 54.727581][ T5079] CPU0 CPU1 [ 54.733119][ T5079] ---- ---- [ 54.738467][ T5079] lock(&hdev->cmd_sync_work_lock); [ 54.743743][ T5079] lock((work_completion)(&hdev->cmd_sync_work)); [ 54.752842][ T5079] lock(&hdev->cmd_sync_work_lock); [ 54.760737][ T5079] lock((work_completion)(&hdev->cmd_sync_work)); [ 54.767367][ T5079] [ 54.767367][ T5079] *** DEADLOCK *** [ 54.767367][ T5079] [ 54.775512][ T5079] 1 lock held by syz-executor.0/5079: [ 54.780888][ T5079] #0: ffff888022388920 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}, at: hci_cmd_sync_clear+0x3c/0x2a0 [ 54.791613][ T5079] [ 54.791613][ T5079] stack backtrace: [ 54.797497][ T5079] CPU: 0 PID: 5079 Comm: syz-executor.0 Not tainted 6.2.0-next-20230224-syzkaller #0 [ 54.806945][ T5079] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/16/2023 [ 54.817078][ T5079] Call Trace: [ 54.820350][ T5079] [ 54.823280][ T5079] dump_stack_lvl+0xd9/0x150 [ 54.827874][ T5079] check_noncircular+0x25f/0x2e0 [ 54.832894][ T5079] ? register_lock_class+0xbe/0x1120 [ 54.838172][ T5079] ? print_circular_bug+0x5c0/0x5c0 [ 54.843369][ T5079] ? is_dynamic_key.part.0+0x1f0/0x1f0 [ 54.848932][ T5079] __lock_acquire+0x2ec7/0x5d40 [ 54.853787][ T5079] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 54.859762][ T5079] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 54.865740][ T5079] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 54.871717][ T5079] ? find_held_lock+0x2d/0x110 [ 54.876483][ T5079] lock_acquire.part.0+0x11a/0x370 [ 54.881677][ T5079] ? __flush_work+0xdd/0xb60 [ 54.886266][ T5079] ? lock_release+0x780/0x780 [ 54.890939][ T5079] ? __flush_work+0xdd/0xb60 [ 54.895524][ T5079] ? rcu_read_lock_sched_held+0x3e/0x70 [ 54.901068][ T5079] ? trace_lock_acquire+0x1f1/0x2b0 [ 54.906261][ T5079] ? __flush_work+0xdd/0xb60 [ 54.910856][ T5079] ? lock_acquire+0x32/0xc0 [ 54.915353][ T5079] ? __flush_work+0xdd/0xb60 [ 54.919949][ T5079] __flush_work+0x109/0xb60 [ 54.924538][ T5079] ? __flush_work+0xdd/0xb60 [ 54.929126][ T5079] ? _raw_spin_unlock_irq+0x23/0x50 [ 54.934325][ T5079] ? print_usage_bug.part.0+0x660/0x660 [ 54.940139][ T5079] ? mod_delayed_work_on+0x220/0x220 [ 54.945511][ T5079] ? lock_release+0x780/0x780 [ 54.950182][ T5079] ? hci_cmd_sync_clear+0x3c/0x2a0 [ 54.955292][ T5079] ? mark_held_locks+0x9f/0xe0 [ 54.960073][ T5079] __cancel_work_timer+0x3f9/0x570 [ 54.965182][ T5079] ? work_on_cpu_safe+0xe0/0xe0 [ 54.970030][ T5079] ? __cancel_work_timer+0x339/0x570 [ 54.975315][ T5079] ? work_on_cpu_safe+0xe0/0xe0 [ 54.980165][ T5079] ? hci_unregister_dev+0x157/0x580 [ 54.985536][ T5079] ? lock_downgrade+0x690/0x690 [ 54.990398][ T5079] ? do_raw_write_lock+0x11e/0x3b0 [ 54.995514][ T5079] hci_cmd_sync_clear+0x48/0x2a0 [ 55.000474][ T5079] hci_unregister_dev+0x16b/0x580 [ 55.006820][ T5079] vhci_release+0x80/0xf0 [ 55.011175][ T5079] __fput+0x27c/0xa90 [ 55.015175][ T5079] ? vhci_close_dev+0x50/0x50 [ 55.019885][ T5079] task_work_run+0x16f/0x270 [ 55.024499][ T5079] ? task_work_cancel+0x30/0x30 [ 55.029455][ T5079] do_exit+0xb42/0x2b60 [ 55.033891][ T5079] ? find_held_lock+0x2d/0x110 [ 55.038655][ T5079] ? get_signal+0x89d/0x25b0 [ 55.043241][ T5079] ? mm_update_next_owner+0x7b0/0x7b0 [ 55.048608][ T5079] do_group_exit+0xd4/0x2a0 [ 55.053111][ T5079] get_signal+0x2315/0x25b0 [ 55.057610][ T5079] ? lockdep_hardirqs_on+0x7d/0x100 [ 55.062822][ T5079] ? exit_signals+0x910/0x910 [ 55.067511][ T5079] ? slab_free_freelist_hook+0x8b/0x1c0 [ 55.073092][ T5079] ? putname+0x102/0x140 [ 55.077360][ T5079] arch_do_signal_or_restart+0x79/0x5c0 [ 55.083018][ T5079] ? get_sigframe_size+0x10/0x10 [ 55.087956][ T5079] ? putname+0x102/0x140 [ 55.092209][ T5079] exit_to_user_mode_prepare+0x15f/0x250 [ 55.097845][ T5079] syscall_exit_to_user_mode+0x1d/0x50 [ 55.103315][ T5079] do_syscall_64+0x46/0xb0 [ 55.107731][ T5079] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 55.113729][ T5079] RIP: 0033:0x7ff20608d567 [ 55.118159][ T5079] Code: Unable to access opcode bytes at 0x7ff20608d53d. [ 55.125181][ T5079] RSP: 002b:00007fffc36b4528 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6 [ 55.133769][ T5079] RAX: fffffffffffffffe RBX: 0000000000000003 RCX: 00007ff20608d567 [ 55.141731][ T5079] RDX: 00007fffc36b45fc RSI: 000000000000000a RDI: 00007fffc36b45f0 [ 55.149698][ T5079] RBP: 00007fffc36b45f0 R08: 00000000ffffffff R09: 00007fffc36b43c0 [ 55.157661][ T5079] R10: 0000555555e77853 R11: 0000000000000246 R12: 00007ff2060e6b24 [ 55.165631][ T5079] R13: 00007fffc36b56b0 R14: 0000555555e77810 R15: 00007fffc36b56f0 [ 55.173864][ T5079] [ 55.185025][ T5080] Bluetooth: hci0: command 0x0409 tx timeout executing program [ 56.446876][ T5070] damon-dbgfs: DAMON debugfs interface is deprecated, so users should move to DAMON_SYSFS. If you cannot, please report your usecase to damon@lists.linux.dev and linux-mm@kvack.org. [ 56.559067][ T5070] can: request_module (can-proto-0) failed. [ 56.582760][ T5070] can: request_module (can-proto-0) failed. [ 56.605999][ T5070] can: request_module (can-proto-0) failed. [ 57.290711][ T5070] base_sock_release(ffff888075d7c200) sk=ffff8881470fb000