Warning: Permanently added '10.128.10.0' (ECDSA) to the list of known hosts. 2023/02/24 14:04:06 fuzzer started 2023/02/24 14:04:06 connecting to host at 10.128.0.169:44293 2023/02/24 14:04:06 checking machine... 2023/02/24 14:04:06 checking revisions... 2023/02/24 14:04:06 testing simple program... syzkaller login: [ 51.684866][ T5078] cgroup: Unknown subsys name 'net' [ 51.787526][ T5078] cgroup: Unknown subsys name 'rlimit' [ 51.917749][ T5071] memfd_create() without MFD_EXEC nor MFD_NOEXEC_SEAL, pid=5071 'syz-fuzzer' [ 52.030317][ T5081] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 52.039219][ T5081] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 52.047721][ T5081] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 52.056488][ T5081] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 52.065216][ T5081] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 52.072768][ T5081] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 52.190998][ T5080] chnl_net:caif_netlink_parms(): no params data found [ 52.236679][ T5080] bridge0: port 1(bridge_slave_0) entered blocking state [ 52.246646][ T5080] bridge0: port 1(bridge_slave_0) entered disabled state [ 52.254167][ T5080] bridge_slave_0: entered allmulticast mode [ 52.261209][ T5080] bridge_slave_0: entered promiscuous mode [ 52.269660][ T5080] bridge0: port 2(bridge_slave_1) entered blocking state [ 52.277314][ T5080] bridge0: port 2(bridge_slave_1) entered disabled state [ 52.284764][ T5080] bridge_slave_1: entered allmulticast mode [ 52.291600][ T5080] bridge_slave_1: entered promiscuous mode [ 52.312197][ T5080] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 52.323155][ T5080] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 52.347325][ T5080] team0: Port device team_slave_0 added [ 52.354830][ T5080] team0: Port device team_slave_1 added [ 52.372391][ T5080] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 52.379353][ T5080] 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. [ 52.405422][ T5080] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 52.418192][ T5080] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 52.425342][ T5080] 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. [ 52.451934][ T5080] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 52.483251][ T5080] hsr_slave_0: entered promiscuous mode [ 52.489347][ T5080] hsr_slave_1: entered promiscuous mode [ 52.571517][ T5080] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 52.582886][ T5080] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 52.593155][ T5080] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 52.602779][ T5080] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 52.626021][ T5080] bridge0: port 2(bridge_slave_1) entered blocking state [ 52.633230][ T5080] bridge0: port 2(bridge_slave_1) entered forwarding state [ 52.641460][ T5080] bridge0: port 1(bridge_slave_0) entered blocking state [ 52.648552][ T5080] bridge0: port 1(bridge_slave_0) entered forwarding state [ 52.697145][ T5080] 8021q: adding VLAN 0 to HW filter on device bond0 [ 52.709565][ T5092] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 52.721087][ T5092] bridge0: port 1(bridge_slave_0) entered disabled state [ 52.729882][ T5092] bridge0: port 2(bridge_slave_1) entered disabled state [ 52.738670][ T5092] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 52.752431][ T5080] 8021q: adding VLAN 0 to HW filter on device team0 [ 52.764727][ T5092] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 52.773921][ T5092] bridge0: port 1(bridge_slave_0) entered blocking state [ 52.781092][ T5092] bridge0: port 1(bridge_slave_0) entered forwarding state [ 52.803536][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 52.812210][ T5091] bridge0: port 2(bridge_slave_1) entered blocking state [ 52.819253][ T5091] bridge0: port 2(bridge_slave_1) entered forwarding state [ 52.828090][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 52.839351][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 52.847993][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 52.865509][ T5080] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 52.876693][ T5080] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 52.891221][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 52.900559][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 52.913156][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 53.027622][ T5080] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 53.035728][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 53.044323][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 53.070337][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 53.079222][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 53.088033][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 53.097217][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 53.106504][ T5080] veth0_vlan: entered promiscuous mode [ 53.120462][ T5080] veth1_vlan: entered promiscuous mode [ 53.141343][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 53.153188][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 53.163197][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 53.173559][ T5080] veth0_macvtap: entered promiscuous mode [ 53.182569][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 53.193162][ T5080] veth1_macvtap: entered promiscuous mode [ 53.208275][ T5080] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 53.216341][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_0: link becomes ready [ 53.225411][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 53.237801][ T5080] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 53.247076][ T4407] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 53.255754][ T4407] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 53.267692][ T5080] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 53.277253][ T5080] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 53.294269][ T5080] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 53.303253][ T5080] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 53.361941][ T41] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 53.376366][ T41] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 53.387471][ T4407] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 53.397785][ T75] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 53.407008][ T75] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 53.417304][ T14] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready 2023/02/24 14:04:08 building call list... [ 53.587608][ T5080] [ 53.590159][ T5080] ====================================================== [ 53.597286][ T5080] WARNING: possible circular locking dependency detected [ 53.604309][ T5080] 6.2.0-next-20230224-syzkaller #0 Not tainted [ 53.610467][ T5080] ------------------------------------------------------ [ 53.617542][ T5080] syz-executor.0/5080 is trying to acquire lock: [ 53.623876][ T5080] ffff888022558880 ((work_completion)(&hdev->cmd_sync_work)){+.+.}-{0:0}, at: __flush_work+0xdd/0xb60 [ 53.634930][ T5080] [ 53.634930][ T5080] but task is already holding lock: [ 53.642284][ T5080] ffff888022558920 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}, at: hci_cmd_sync_clear+0x3c/0x2a0 [ 53.652573][ T5080] [ 53.652573][ T5080] which lock already depends on the new lock. [ 53.652573][ T5080] [ 53.663331][ T5080] [ 53.663331][ T5080] the existing dependency chain (in reverse order) is: [ 53.672778][ T5080] [ 53.672778][ T5080] -> #1 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}: [ 53.681669][ T5080] __mutex_lock+0x12f/0x1350 [ 53.686818][ T5080] hci_cmd_sync_work+0x26f/0x450 [ 53.692375][ T5080] process_one_work+0x9bf/0x1820 [ 53.697936][ T5080] worker_thread+0x669/0x1090 [ 53.703147][ T5080] kthread+0x2e8/0x3a0 [ 53.707815][ T5080] ret_from_fork+0x1f/0x30 [ 53.712937][ T5080] [ 53.712937][ T5080] -> #0 ((work_completion)(&hdev->cmd_sync_work)){+.+.}-{0:0}: [ 53.722679][ T5080] __lock_acquire+0x2ec7/0x5d40 [ 53.728053][ T5080] lock_acquire.part.0+0x11a/0x370 [ 53.733679][ T5080] __flush_work+0x109/0xb60 [ 53.738696][ T5080] __cancel_work_timer+0x3f9/0x570 [ 53.744324][ T5080] hci_cmd_sync_clear+0x48/0x2a0 [ 53.749782][ T5080] hci_unregister_dev+0x16b/0x580 [ 53.755329][ T5080] vhci_release+0x80/0xf0 [ 53.760179][ T5080] __fput+0x27c/0xa90 [ 53.764776][ T5080] task_work_run+0x16f/0x270 [ 53.769891][ T5080] do_exit+0xb42/0x2b60 [ 53.774563][ T5080] do_group_exit+0xd4/0x2a0 [ 53.779576][ T5080] get_signal+0x2315/0x25b0 [ 53.784700][ T5080] arch_do_signal_or_restart+0x79/0x5c0 [ 53.790935][ T5080] exit_to_user_mode_prepare+0x15f/0x250 [ 53.797100][ T5080] syscall_exit_to_user_mode+0x1d/0x50 [ 53.803606][ T5080] do_syscall_64+0x46/0xb0 [ 53.808539][ T5080] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 53.815039][ T5080] [ 53.815039][ T5080] other info that might help us debug this: [ 53.815039][ T5080] [ 53.825514][ T5080] Possible unsafe locking scenario: [ 53.825514][ T5080] [ 53.832950][ T5080] CPU0 CPU1 [ 53.838570][ T5080] ---- ---- [ 53.843931][ T5080] lock(&hdev->cmd_sync_work_lock); [ 53.849221][ T5080] lock((work_completion)(&hdev->cmd_sync_work)); [ 53.858230][ T5080] lock(&hdev->cmd_sync_work_lock); [ 53.866121][ T5080] lock((work_completion)(&hdev->cmd_sync_work)); [ 53.872787][ T5080] [ 53.872787][ T5080] *** DEADLOCK *** [ 53.872787][ T5080] [ 53.880917][ T5080] 1 lock held by syz-executor.0/5080: [ 53.886280][ T5080] #0: ffff888022558920 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}, at: hci_cmd_sync_clear+0x3c/0x2a0 [ 53.897247][ T5080] [ 53.897247][ T5080] stack backtrace: [ 53.903119][ T5080] CPU: 0 PID: 5080 Comm: syz-executor.0 Not tainted 6.2.0-next-20230224-syzkaller #0 [ 53.912654][ T5080] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/16/2023 [ 53.922872][ T5080] Call Trace: [ 53.926227][ T5080] [ 53.929235][ T5080] dump_stack_lvl+0xd9/0x150 [ 53.933825][ T5080] check_noncircular+0x25f/0x2e0 [ 53.939457][ T5080] ? register_lock_class+0xbe/0x1120 [ 53.944736][ T5080] ? print_circular_bug+0x5c0/0x5c0 [ 53.950028][ T5080] ? is_dynamic_key.part.0+0x1f0/0x1f0 [ 53.955484][ T5080] __lock_acquire+0x2ec7/0x5d40 [ 53.960421][ T5080] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 53.966394][ T5080] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 53.972384][ T5080] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 53.978476][ T5080] ? find_held_lock+0x2d/0x110 [ 53.983246][ T5080] lock_acquire.part.0+0x11a/0x370 [ 53.988532][ T5080] ? __flush_work+0xdd/0xb60 [ 53.993123][ T5080] ? lock_release+0x780/0x780 [ 53.997795][ T5080] ? __flush_work+0xdd/0xb60 [ 54.002469][ T5080] ? rcu_read_lock_sched_held+0x3e/0x70 [ 54.008012][ T5080] ? trace_lock_acquire+0x1f1/0x2b0 [ 54.013205][ T5080] ? __flush_work+0xdd/0xb60 [ 54.017795][ T5080] ? lock_acquire+0x32/0xc0 [ 54.022292][ T5080] ? __flush_work+0xdd/0xb60 [ 54.026883][ T5080] __flush_work+0x109/0xb60 [ 54.031387][ T5080] ? __flush_work+0xdd/0xb60 [ 54.036063][ T5080] ? _raw_spin_unlock_irq+0x23/0x50 [ 54.041259][ T5080] ? print_usage_bug.part.0+0x660/0x660 [ 54.046819][ T5080] ? mod_delayed_work_on+0x220/0x220 [ 54.052105][ T5080] ? lock_release+0x780/0x780 [ 54.056776][ T5080] ? hci_cmd_sync_clear+0x3c/0x2a0 [ 54.062005][ T5080] ? mark_held_locks+0x9f/0xe0 [ 54.066769][ T5080] __cancel_work_timer+0x3f9/0x570 [ 54.071901][ T5080] ? work_on_cpu_safe+0xe0/0xe0 [ 54.076751][ T5080] ? __cancel_work_timer+0x339/0x570 [ 54.082229][ T5080] ? work_on_cpu_safe+0xe0/0xe0 [ 54.087106][ T5080] ? hci_unregister_dev+0x157/0x580 [ 54.092410][ T5080] ? lock_downgrade+0x690/0x690 [ 54.097290][ T5080] ? do_raw_write_lock+0x11e/0x3b0 [ 54.102416][ T5080] hci_cmd_sync_clear+0x48/0x2a0 [ 54.107359][ T5080] hci_unregister_dev+0x16b/0x580 [ 54.112404][ T5080] vhci_release+0x80/0xf0 [ 54.116738][ T5080] __fput+0x27c/0xa90 [ 54.120731][ T5080] ? vhci_close_dev+0x50/0x50 [ 54.125419][ T5080] task_work_run+0x16f/0x270 [ 54.130022][ T5080] ? task_work_cancel+0x30/0x30 [ 54.134967][ T5080] do_exit+0xb42/0x2b60 [ 54.139120][ T5080] ? find_held_lock+0x2d/0x110 [ 54.143880][ T5080] ? get_signal+0x89d/0x25b0 [ 54.148467][ T5080] ? mm_update_next_owner+0x7b0/0x7b0 [ 54.153837][ T5080] do_group_exit+0xd4/0x2a0 [ 54.158334][ T5080] get_signal+0x2315/0x25b0 [ 54.162855][ T5080] ? putname+0x102/0x140 [ 54.167106][ T5080] ? exit_signals+0x910/0x910 [ 54.171783][ T5080] arch_do_signal_or_restart+0x79/0x5c0 [ 54.177334][ T5080] ? get_sigframe_size+0x10/0x10 [ 54.182274][ T5080] ? __ia32_sys_rmdir+0x110/0x110 [ 54.187316][ T5080] ? __check_object_size+0x333/0x6e0 [ 54.192637][ T5080] exit_to_user_mode_prepare+0x15f/0x250 [ 54.198291][ T5080] syscall_exit_to_user_mode+0x1d/0x50 [ 54.203759][ T5080] do_syscall_64+0x46/0xb0 [ 54.208182][ T5080] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 54.214073][ T5080] RIP: 0033:0x7ff1c808ba67 [ 54.218493][ T5080] Code: Unable to access opcode bytes at 0x7ff1c808ba3d. [ 54.225515][ T5080] RSP: 002b:00007ffc576bbfe8 EFLAGS: 00000206 ORIG_RAX: 0000000000000057 [ 54.233938][ T5080] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007ff1c808ba67 [ 54.241996][ T5080] RDX: 00007ffc576bc020 RSI: 00007ffc576bc020 RDI: 00007ffc576bc0b0 [ 54.249979][ T5080] RBP: 00007ffc576bc0b0 R08: 0000000000000001 R09: 00007ffc576bbe80 [ 54.258043][ T5080] R10: 0000555555dd0853 R11: 0000000000000206 R12: 00007ff1c80e6b24 [ 54.266095][ T5080] R13: 00007ffc576bd170 R14: 0000555555dd0810 R15: 00007ffc576bd1b0 [ 54.274065][ T5080] [ 54.280503][ T5081] Bluetooth: hci0: command 0x0409 tx timeout executing program [ 55.565020][ T5077] 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. [ 55.697756][ T5077] can: request_module (can-proto-0) failed. [ 55.720214][ T5077] can: request_module (can-proto-0) failed. [ 55.742683][ T5077] can: request_module (can-proto-0) failed. [ 56.388632][ T5077] base_sock_release(ffff888077148000) sk=ffff88807b213000