Warning: Permanently added '10.128.15.224' (ECDSA) to the list of known hosts. 2023/02/24 05:17:00 fuzzer started 2023/02/24 05:17:00 connecting to host at 10.128.0.169:34841 2023/02/24 05:17:00 checking machine... 2023/02/24 05:17:00 checking revisions... 2023/02/24 05:17:00 testing simple program... syzkaller login: [ 55.389224][ T5078] cgroup: Unknown subsys name 'net' [ 55.520234][ T5078] cgroup: Unknown subsys name 'rlimit' [ 55.621068][ T5071] memfd_create() without MFD_EXEC nor MFD_NOEXEC_SEAL, pid=5071 'syz-fuzzer' [ 55.727008][ T5082] Bluetooth: hci0: unexpected cc 0x0c03 length: 249 > 1 [ 55.735195][ T5082] Bluetooth: hci0: unexpected cc 0x1003 length: 249 > 9 [ 55.742700][ T5082] Bluetooth: hci0: unexpected cc 0x1001 length: 249 > 9 [ 55.751715][ T5082] Bluetooth: hci0: unexpected cc 0x0c23 length: 249 > 4 [ 55.759702][ T5082] Bluetooth: hci0: unexpected cc 0x0c25 length: 249 > 3 [ 55.767778][ T5082] Bluetooth: hci0: unexpected cc 0x0c38 length: 249 > 2 [ 55.887902][ T5080] chnl_net:caif_netlink_parms(): no params data found [ 55.928490][ T5080] bridge0: port 1(bridge_slave_0) entered blocking state [ 55.936359][ T5080] bridge0: port 1(bridge_slave_0) entered disabled state [ 55.944118][ T5080] bridge_slave_0: entered allmulticast mode [ 55.950762][ T5080] bridge_slave_0: entered promiscuous mode [ 55.959113][ T5080] bridge0: port 2(bridge_slave_1) entered blocking state [ 55.966780][ T5080] bridge0: port 2(bridge_slave_1) entered disabled state [ 55.974072][ T5080] bridge_slave_1: entered allmulticast mode [ 55.980645][ T5080] bridge_slave_1: entered promiscuous mode [ 55.999922][ T5080] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 56.011073][ T5080] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 56.033018][ T5080] team0: Port device team_slave_0 added [ 56.040773][ T5080] team0: Port device team_slave_1 added [ 56.057390][ T5080] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 56.064783][ 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. [ 56.091761][ T5080] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 56.104758][ T5080] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 56.111724][ 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. [ 56.138249][ T5080] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 56.166816][ T5080] hsr_slave_0: entered promiscuous mode [ 56.172990][ T5080] hsr_slave_1: entered promiscuous mode [ 56.251883][ T5080] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 56.262229][ T5080] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 56.271333][ T5080] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 56.281763][ T5080] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 56.301965][ T5080] bridge0: port 2(bridge_slave_1) entered blocking state [ 56.309157][ T5080] bridge0: port 2(bridge_slave_1) entered forwarding state [ 56.317023][ T5080] bridge0: port 1(bridge_slave_0) entered blocking state [ 56.324115][ T5080] bridge0: port 1(bridge_slave_0) entered forwarding state [ 56.367541][ T5080] 8021q: adding VLAN 0 to HW filter on device bond0 [ 56.379834][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 56.389518][ T5090] bridge0: port 1(bridge_slave_0) entered disabled state [ 56.398099][ T5090] bridge0: port 2(bridge_slave_1) entered disabled state [ 56.407604][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 56.420444][ T5080] 8021q: adding VLAN 0 to HW filter on device team0 [ 56.431774][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 56.440508][ T5090] bridge0: port 1(bridge_slave_0) entered blocking state [ 56.447907][ T5090] bridge0: port 1(bridge_slave_0) entered forwarding state [ 56.467281][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 56.476139][ T5091] bridge0: port 2(bridge_slave_1) entered blocking state [ 56.483186][ T5091] bridge0: port 2(bridge_slave_1) entered forwarding state [ 56.492083][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 56.505298][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 56.513340][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 56.526768][ T26] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 56.539007][ T5080] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 56.551833][ T5080] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 56.561384][ T5091] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 56.684609][ T5080] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 56.692554][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 56.701111][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 56.725201][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 56.734572][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 56.743257][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 56.751956][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 56.762692][ T5080] veth0_vlan: entered promiscuous mode [ 56.772858][ T5080] veth1_vlan: entered promiscuous mode [ 56.791535][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 56.800048][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 56.809503][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 56.819925][ T5080] veth0_macvtap: entered promiscuous mode [ 56.830816][ T5080] veth1_macvtap: entered promiscuous mode [ 56.846205][ T5080] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 56.855012][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 56.864980][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 56.876021][ T5080] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 56.884346][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): batadv_slave_1: link becomes ready [ 56.892778][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready [ 56.905743][ T5080] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.914698][ T5080] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.923378][ T5080] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.932591][ T5080] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 56.994573][ T11] wlan0: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 57.002582][ T11] wlan0: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 57.015233][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready [ 57.032765][ T11] wlan1: Created IBSS using preconfigured BSSID 50:50:50:50:50:50 [ 57.041970][ T11] wlan1: Creating new IBSS network, BSSID 50:50:50:50:50:50 [ 57.050858][ T5090] IPv6: ADDRCONF(NETDEV_CHANGE): wlan1: link becomes ready 2023/02/24 05:17:02 building call list... [ 57.242563][ T5080] [ 57.244979][ T5080] ====================================================== [ 57.252178][ T5080] WARNING: possible circular locking dependency detected [ 57.259366][ T5080] 6.2.0-next-20230224-syzkaller #0 Not tainted [ 57.265521][ T5080] ------------------------------------------------------ [ 57.272540][ T5080] syz-executor.0/5080 is trying to acquire lock: [ 57.279013][ T5080] ffff888029944880 ((work_completion)(&hdev->cmd_sync_work)){+.+.}-{0:0}, at: __flush_work+0xdd/0xb60 [ 57.290266][ T5080] [ 57.290266][ T5080] but task is already holding lock: [ 57.297637][ T5080] ffff888029944920 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}, at: hci_cmd_sync_clear+0x3c/0x2a0 [ 57.308015][ T5080] [ 57.308015][ T5080] which lock already depends on the new lock. [ 57.308015][ T5080] [ 57.318413][ T5080] [ 57.318413][ T5080] the existing dependency chain (in reverse order) is: [ 57.327508][ T5080] [ 57.327508][ T5080] -> #1 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}: [ 57.336131][ T5080] __mutex_lock+0x12f/0x1350 [ 57.341278][ T5080] hci_cmd_sync_work+0x26f/0x450 [ 57.346766][ T5080] process_one_work+0x9bf/0x1820 [ 57.352237][ T5080] worker_thread+0x669/0x1090 [ 57.357440][ T5080] kthread+0x2e8/0x3a0 [ 57.362035][ T5080] ret_from_fork+0x1f/0x30 [ 57.366981][ T5080] [ 57.366981][ T5080] -> #0 ((work_completion)(&hdev->cmd_sync_work)){+.+.}-{0:0}: [ 57.376813][ T5080] __lock_acquire+0x2ec7/0x5d40 [ 57.382198][ T5080] lock_acquire.part.0+0x11a/0x370 [ 57.387846][ T5080] __flush_work+0x109/0xb60 [ 57.392882][ T5080] __cancel_work_timer+0x3f9/0x570 [ 57.398612][ T5080] hci_cmd_sync_clear+0x48/0x2a0 [ 57.404164][ T5080] hci_unregister_dev+0x16b/0x580 [ 57.409805][ T5080] vhci_release+0x80/0xf0 [ 57.414669][ T5080] __fput+0x27c/0xa90 [ 57.419182][ T5080] task_work_run+0x16f/0x270 [ 57.424311][ T5080] do_exit+0xb42/0x2b60 [ 57.429004][ T5080] do_group_exit+0xd4/0x2a0 [ 57.434042][ T5080] get_signal+0x2315/0x25b0 [ 57.439126][ T5080] arch_do_signal_or_restart+0x79/0x5c0 [ 57.445213][ T5080] exit_to_user_mode_prepare+0x15f/0x250 [ 57.451386][ T5080] syscall_exit_to_user_mode+0x1d/0x50 [ 57.457387][ T5080] do_syscall_64+0x46/0xb0 [ 57.462430][ T5080] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 57.469029][ T5080] [ 57.469029][ T5080] other info that might help us debug this: [ 57.469029][ T5080] [ 57.479275][ T5080] Possible unsafe locking scenario: [ 57.479275][ T5080] [ 57.486820][ T5080] CPU0 CPU1 [ 57.492464][ T5080] ---- ---- [ 57.497838][ T5080] lock(&hdev->cmd_sync_work_lock); [ 57.503137][ T5080] lock((work_completion)(&hdev->cmd_sync_work)); [ 57.512255][ T5080] lock(&hdev->cmd_sync_work_lock); [ 57.520065][ T5080] lock((work_completion)(&hdev->cmd_sync_work)); [ 57.526569][ T5080] [ 57.526569][ T5080] *** DEADLOCK *** [ 57.526569][ T5080] [ 57.534895][ T5080] 1 lock held by syz-executor.0/5080: [ 57.540287][ T5080] #0: ffff888029944920 (&hdev->cmd_sync_work_lock){+.+.}-{3:3}, at: hci_cmd_sync_clear+0x3c/0x2a0 [ 57.551045][ T5080] [ 57.551045][ T5080] stack backtrace: [ 57.556942][ T5080] CPU: 0 PID: 5080 Comm: syz-executor.0 Not tainted 6.2.0-next-20230224-syzkaller #0 [ 57.566504][ T5080] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 02/16/2023 [ 57.576575][ T5080] Call Trace: [ 57.579859][ T5080] [ 57.582878][ T5080] dump_stack_lvl+0xd9/0x150 [ 57.587499][ T5080] check_noncircular+0x25f/0x2e0 [ 57.592448][ T5080] ? register_lock_class+0xbe/0x1120 [ 57.597743][ T5080] ? print_circular_bug+0x5c0/0x5c0 [ 57.603039][ T5080] ? is_dynamic_key.part.0+0x1f0/0x1f0 [ 57.608515][ T5080] __lock_acquire+0x2ec7/0x5d40 [ 57.613466][ T5080] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 57.619548][ T5080] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 57.625553][ T5080] ? lockdep_hardirqs_on_prepare+0x410/0x410 [ 57.631545][ T5080] ? find_held_lock+0x2d/0x110 [ 57.636324][ T5080] lock_acquire.part.0+0x11a/0x370 [ 57.641451][ T5080] ? __flush_work+0xdd/0xb60 [ 57.646147][ T5080] ? lock_release+0x780/0x780 [ 57.650842][ T5080] ? __flush_work+0xdd/0xb60 [ 57.655456][ T5080] ? rcu_read_lock_sched_held+0x3e/0x70 [ 57.661027][ T5080] ? trace_lock_acquire+0x1f1/0x2b0 [ 57.666254][ T5080] ? __flush_work+0xdd/0xb60 [ 57.670888][ T5080] ? lock_acquire+0x32/0xc0 [ 57.675411][ T5080] ? __flush_work+0xdd/0xb60 [ 57.680026][ T5080] __flush_work+0x109/0xb60 [ 57.684547][ T5080] ? __flush_work+0xdd/0xb60 [ 57.689242][ T5080] ? _raw_spin_unlock_irq+0x23/0x50 [ 57.694453][ T5080] ? print_usage_bug.part.0+0x660/0x660 [ 57.700012][ T5080] ? mod_delayed_work_on+0x220/0x220 [ 57.705327][ T5080] ? lock_release+0x780/0x780 [ 57.710117][ T5080] ? hci_cmd_sync_clear+0x3c/0x2a0 [ 57.715445][ T5080] ? mark_held_locks+0x9f/0xe0 [ 57.720237][ T5080] __cancel_work_timer+0x3f9/0x570 [ 57.725457][ T5080] ? work_on_cpu_safe+0xe0/0xe0 [ 57.730327][ T5080] ? __cancel_work_timer+0x339/0x570 [ 57.735628][ T5080] ? work_on_cpu_safe+0xe0/0xe0 [ 57.740502][ T5080] ? hci_unregister_dev+0x157/0x580 [ 57.745717][ T5080] ? lock_downgrade+0x690/0x690 [ 57.750592][ T5080] ? do_raw_write_lock+0x11e/0x3b0 [ 57.755734][ T5080] hci_cmd_sync_clear+0x48/0x2a0 [ 57.760694][ T5080] hci_unregister_dev+0x16b/0x580 [ 57.765739][ T5080] vhci_release+0x80/0xf0 [ 57.770090][ T5080] __fput+0x27c/0xa90 [ 57.774127][ T5080] ? vhci_close_dev+0x50/0x50 [ 57.778825][ T5080] task_work_run+0x16f/0x270 [ 57.783444][ T5080] ? task_work_cancel+0x30/0x30 [ 57.788413][ T5080] do_exit+0xb42/0x2b60 [ 57.792592][ T5080] ? find_held_lock+0x2d/0x110 [ 57.797366][ T5080] ? get_signal+0x89d/0x25b0 [ 57.801975][ T5080] ? mm_update_next_owner+0x7b0/0x7b0 [ 57.807373][ T5080] do_group_exit+0xd4/0x2a0 [ 57.811900][ T5080] get_signal+0x2315/0x25b0 [ 57.816566][ T5080] ? putname+0x102/0x140 [ 57.820858][ T5080] ? exit_signals+0x910/0x910 [ 57.825557][ T5080] arch_do_signal_or_restart+0x79/0x5c0 [ 57.831168][ T5080] ? get_sigframe_size+0x10/0x10 [ 57.836391][ T5080] ? __ia32_sys_rmdir+0x110/0x110 [ 57.841522][ T5080] ? __check_object_size+0x333/0x6e0 [ 57.847176][ T5080] exit_to_user_mode_prepare+0x15f/0x250 [ 57.853080][ T5080] syscall_exit_to_user_mode+0x1d/0x50 [ 57.858559][ T5080] do_syscall_64+0x46/0xb0 [ 57.863159][ T5080] entry_SYSCALL_64_after_hwframe+0x63/0xcd [ 57.869072][ T5080] RIP: 0033:0x7f3306c8ba67 [ 57.873503][ T5080] Code: Unable to access opcode bytes at 0x7f3306c8ba3d. [ 57.880525][ T5080] RSP: 002b:00007ffd4c756d58 EFLAGS: 00000206 ORIG_RAX: 0000000000000057 [ 57.888959][ T5080] RAX: 0000000000000000 RBX: 0000000000000000 RCX: 00007f3306c8ba67 [ 57.897314][ T5080] RDX: 00007ffd4c756d90 RSI: 00007ffd4c756d90 RDI: 00007ffd4c756e20 [ 57.905577][ T5080] RBP: 00007ffd4c756e20 R08: 0000000000000001 R09: 00007ffd4c756bf0 [ 57.913817][ T5080] R10: 0000555556750853 R11: 0000000000000206 R12: 00007f3306ce6b24 [ 57.921998][ T5080] R13: 00007ffd4c757ee0 R14: 0000555556750810 R15: 00007ffd4c757f20 [ 57.929998][ T5080] [ 57.937314][ T5082] Bluetooth: hci0: command 0x0409 tx timeout executing program [ 58.756469][ T5069] 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. [ 58.852805][ T5069] can: request_module (can-proto-0) failed. [ 58.874976][ T5069] can: request_module (can-proto-0) failed. [ 58.896931][ T5069] can: request_module (can-proto-0) failed. [ 59.538827][ T5069] base_sock_release(ffff888076585400) sk=ffff888017d1f000