[ OK ] Started Serial Getty on ttyS0. [ OK ] Reached target Login Prompts. [ OK ] Reached target Multi-User System. [ OK ] Reached target Graphical Interface. Starting Update UTMP about System Runlevel Changes... Debian GNU/Linux 9 syzkaller ttyS0 Warning: Permanently added '10.128.0.57' (ECDSA) to the list of known hosts. syzkaller login: [ 53.955381][ T8465] IPVS: ftp: loaded support on port[0] = 21 [ 54.042254][ T8465] chnl_net:caif_netlink_parms(): no params data found [ 54.102464][ T8465] bridge0: port 1(bridge_slave_0) entered blocking state [ 54.110990][ T8465] bridge0: port 1(bridge_slave_0) entered disabled state [ 54.120365][ T8465] device bridge_slave_0 entered promiscuous mode [ 54.130518][ T8465] bridge0: port 2(bridge_slave_1) entered blocking state [ 54.138194][ T8465] bridge0: port 2(bridge_slave_1) entered disabled state [ 54.146758][ T8465] device bridge_slave_1 entered promiscuous mode [ 54.166430][ T8465] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 54.178376][ T8465] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 54.200950][ T8465] team0: Port device team_slave_0 added [ 54.208270][ T8465] team0: Port device team_slave_1 added [ 54.225745][ T8465] batman_adv: batadv0: Adding interface: batadv_slave_0 [ 54.232702][ T8465] 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. [ 54.258983][ T8465] batman_adv: batadv0: Not using interface batadv_slave_0 (retrying later): interface not active [ 54.272588][ T8465] batman_adv: batadv0: Adding interface: batadv_slave_1 [ 54.280053][ T8465] 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. [ 54.306231][ T8465] batman_adv: batadv0: Not using interface batadv_slave_1 (retrying later): interface not active [ 54.333095][ T8465] device hsr_slave_0 entered promiscuous mode [ 54.339757][ T8465] device hsr_slave_1 entered promiscuous mode [ 54.435212][ T8465] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 54.445000][ T8465] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 54.454982][ T8465] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 54.463445][ T8465] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 54.487106][ T8465] bridge0: port 2(bridge_slave_1) entered blocking state [ 54.494220][ T8465] bridge0: port 2(bridge_slave_1) entered forwarding state [ 54.501960][ T8465] bridge0: port 1(bridge_slave_0) entered blocking state [ 54.509136][ T8465] bridge0: port 1(bridge_slave_0) entered forwarding state [ 54.552598][ T8465] 8021q: adding VLAN 0 to HW filter on device bond0 [ 54.566218][ T3179] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 54.579507][ T3179] bridge0: port 1(bridge_slave_0) entered disabled state [ 54.588319][ T3179] bridge0: port 2(bridge_slave_1) entered disabled state [ 54.599081][ T3179] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 54.612769][ T8465] 8021q: adding VLAN 0 to HW filter on device team0 [ 54.624224][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 54.633151][ T5] bridge0: port 1(bridge_slave_0) entered blocking state [ 54.640297][ T5] bridge0: port 1(bridge_slave_0) entered forwarding state [ 54.652865][ T35] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 54.662407][ T35] bridge0: port 2(bridge_slave_1) entered blocking state [ 54.669659][ T35] bridge0: port 2(bridge_slave_1) entered forwarding state [ 54.687472][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 54.696207][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 54.709730][ T35] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 54.725334][ T8465] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 54.736423][ T8465] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 54.749678][ T2988] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 54.758701][ T2988] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 54.767841][ T2988] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 54.784674][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 54.792040][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 54.807547][ T8465] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 54.826742][ T2988] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_virt_wifi: link becomes ready [ 54.847419][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_vlan: link becomes ready [ 54.855705][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): vlan0: link becomes ready [ 54.863266][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): vlan1: link becomes ready [ 54.877375][ T8465] device veth0_vlan entered promiscuous mode [ 54.888695][ T8465] device veth1_vlan entered promiscuous mode [ 54.910160][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan0: link becomes ready [ 54.918830][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): macvlan1: link becomes ready [ 54.927749][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_macvtap: link becomes ready [ 54.939927][ T8465] device veth0_macvtap entered promiscuous mode [ 54.949262][ T8465] device veth1_macvtap entered promiscuous mode [ 54.967715][ T8465] batman_adv: batadv0: Interface activated: batadv_slave_0 [ 54.975781][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_batadv: link becomes ready [ 54.986296][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): macvtap0: link becomes ready [ 54.998692][ T8465] batman_adv: batadv0: Interface activated: batadv_slave_1 [ 55.006292][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_batadv: link becomes ready executing program [ 55.019501][ T8465] netdevsim netdevsim0 netdevsim0: set [1, 0] type 2 family 0 port 6081 - 0 [ 55.031528][ T8465] netdevsim netdevsim0 netdevsim1: set [1, 0] type 2 family 0 port 6081 - 0 [ 55.042160][ T8465] netdevsim netdevsim0 netdevsim2: set [1, 0] type 2 family 0 port 6081 - 0 [ 55.053300][ T8465] netdevsim netdevsim0 netdevsim3: set [1, 0] type 2 family 0 port 6081 - 0 [ 55.204564][ C1] [ 55.206932][ C1] ================================ [ 55.212024][ C1] WARNING: inconsistent lock state [ 55.217120][ C1] 5.10.0-rc4-syzkaller #0 Not tainted [ 55.222470][ C1] -------------------------------- [ 55.227816][ C1] inconsistent {SOFTIRQ-ON-W} -> {IN-SOFTIRQ-W} usage. [ 55.234676][ C1] kworker/1:3/8675 [HC0[0]:SC1[1]:HE1:SE0] takes: [ 55.241055][ C1] ffff888140dd94a8 (&file_data->lock){+.?.}-{2:2}, at: io_file_data_ref_zero+0x6a/0x3a0 [ 55.250755][ C1] {SOFTIRQ-ON-W} state was registered at: [ 55.256449][ C1] lock_acquire+0x114/0x5e0 [ 55.261008][ C1] _raw_spin_lock+0x2a/0x40 [ 55.265572][ C1] __se_sys_io_uring_register+0x3aee/0x3f90 [ 55.271537][ C1] do_syscall_64+0x2d/0x70 [ 55.276009][ C1] entry_SYSCALL_64_after_hwframe+0x44/0xa9 [ 55.281958][ C1] irq event stamp: 40498 [ 55.286172][ C1] hardirqs last enabled at (40498): [] _raw_spin_unlock_irqrestore+0x2e/0x60 [ 55.296567][ C1] hardirqs last disabled at (40497): [] _raw_spin_lock_irqsave+0x4d/0xa0 [ 55.306532][ C1] softirqs last enabled at (40390): [] local_bh_enable+0x5/0x20 [ 55.315783][ C1] softirqs last disabled at (40393): [] asm_call_irq_on_stack+0xf/0x20 [ 55.325919][ C1] [ 55.325919][ C1] other info that might help us debug this: [ 55.333947][ C1] Possible unsafe locking scenario: [ 55.333947][ C1] [ 55.341367][ C1] CPU0 [ 55.344623][ C1] ---- [ 55.347887][ C1] lock(&file_data->lock); [ 55.352358][ C1] [ 55.355800][ C1] lock(&file_data->lock); [ 55.360445][ C1] [ 55.360445][ C1] *** DEADLOCK *** [ 55.360445][ C1] [ 55.368574][ C1] 4 locks held by kworker/1:3/8675: [ 55.373743][ C1] #0: ffff888010464d38 ((wq_completion)events){+.+.}-{0:0}, at: process_one_work+0x6f4/0xfc0 [ 55.384000][ C1] #1: ffffc90001b6fd80 ((work_completion)(&w->work)#2){+.+.}-{0:0}, at: process_one_work+0x733/0xfc0 [ 55.394916][ C1] #2: ffffffff8bce6980 (rcu_callback){....}-{0:0}, at: rcu_lock_acquire+0x0/0x20 [ 55.404098][ C1] #3: ffffffff8bce68c0 (rcu_read_lock){....}-{1:2}, at: rcu_lock_acquire+0x5/0x30 [ 55.413379][ C1] [ 55.413379][ C1] stack backtrace: [ 55.419242][ C1] CPU: 1 PID: 8675 Comm: kworker/1:3 Not tainted 5.10.0-rc4-syzkaller #0 [ 55.427631][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 55.437672][ C1] Workqueue: events iterate_cleanup_work [ 55.443271][ C1] Call Trace: [ 55.446525][ C1] [ 55.449356][ C1] dump_stack+0x137/0x1be [ 55.453670][ C1] ? wake_up_klogd+0xb2/0xf0 [ 55.458262][ C1] print_usage_bug+0xc08/0x1090 [ 55.463084][ C1] ? stack_trace_save+0xad/0x150 [ 55.467991][ C1] ? save_trace+0x5a/0x9e0 [ 55.472389][ C1] mark_lock+0x1953/0x20e0 [ 55.476791][ C1] ? mark_lock+0x136/0x20e0 [ 55.481263][ C1] ? __lock_acquire+0x138a/0x6210 [ 55.486260][ C1] __lock_acquire+0xbff/0x6210 [ 55.491012][ C1] ? rcu_read_lock_sched_held+0x41/0xb0 [ 55.496546][ C1] lock_acquire+0x114/0x5e0 [ 55.501023][ C1] ? io_file_data_ref_zero+0x6a/0x3a0 [ 55.506378][ C1] _raw_spin_lock+0x2a/0x40 [ 55.510858][ C1] ? io_file_data_ref_zero+0x6a/0x3a0 [ 55.516204][ C1] io_file_data_ref_zero+0x6a/0x3a0 [ 55.521371][ C1] percpu_ref_put+0x1cb/0x1d0 [ 55.526033][ C1] ? percpu_ref_noop_confirm_switch+0x10/0x10 [ 55.532067][ C1] rcu_core+0x79b/0x10b0 [ 55.536299][ C1] __do_softirq+0x307/0x6be [ 55.540781][ C1] ? asm_call_irq_on_stack+0xf/0x20 [ 55.545951][ C1] asm_call_irq_on_stack+0xf/0x20 [ 55.550942][ C1] [ 55.553850][ C1] do_softirq_own_stack+0x9a/0xe0 [ 55.558846][ C1] __irq_exit_rcu+0x1d6/0x200 [ 55.563501][ C1] irq_exit_rcu+0x5/0x20 [ 55.567712][ C1] sysvec_apic_timer_interrupt+0xe0/0xf0 [ 55.573312][ C1] asm_sysvec_apic_timer_interrupt+0x12/0x20 [ 55.579265][ C1] RIP: 0010:__local_bh_enable_ip+0xfe/0x170 [ 55.585129][ C1] Code: 89 e8 66 9e f7 07 65 66 8b 05 7e af bc 7e 66 85 c0 75 41 bf 01 00 00 00 e8 1f 34 09 00 e8 2a 74 34 00 fb 65 8b 05 6e 64 bb 7e <85> c0 75 05 e8 10 c1 b9 ff 65 48 8b 04 25 28 00 00 00 48 3b 44 24 [ 55.604705][ C1] RSP: 0018:ffffc90001b6fbb0 EFLAGS: 00000282 [ 55.610742][ C1] RAX: 0000000080000000 RBX: 00000000000001ff RCX: ffffffff81599766 [ 55.618695][ C1] RDX: 0000000000000000 RSI: 0000000000000000 RDI: 0000000000000000 [ 55.626644][ C1] RBP: ffff888021893668 R08: dffffc0000000000 R09: fffffbfff1dd427b [ 55.634605][ C1] R10: fffffbfff1dd427b R11: 0000000000000000 R12: dffffc0000000000 [ 55.643501][ C1] R13: 00000000000026cd R14: ffffffff87c11c35 R15: dffffc0000000000 [ 55.651461][ C1] ? local_bh_enable+0x5/0x20 [ 55.656136][ C1] ? mark_lock+0x136/0x20e0 [ 55.660626][ C1] nf_ct_iterate_cleanup+0x427/0x4d0 [ 55.665882][ C1] ? nf_ct_iterate_cleanup+0x4d0/0x4d0 [ 55.671320][ C1] ? iterate_cleanup_work+0x100/0x100 [ 55.676661][ C1] nf_ct_iterate_cleanup_net+0xfc/0x150 [ 55.682174][ C1] ? iterate_cleanup_work+0x100/0x100 [ 55.687527][ C1] iterate_cleanup_work+0x4c/0x100 [ 55.692619][ C1] process_one_work+0x789/0xfc0 [ 55.697450][ C1] worker_thread+0xaa4/0x1460 [ 55.702100][ C1] kthread+0x36b/0x390 [ 55.706144][ C1] ? rcu_lock_release+0x20/0x20 [ 55.710963][ C1] ? kthread_blkcg+0xd0/0xd0 [ 55.715524][ C1] ret_from_fork+0x1f/0x30