[....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [ 43.277658][ T23] audit: type=1800 audit(1575374684.987:25): pid=8172 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="cron" dev="sda1" ino=2414 res=0 [ 43.307029][ T23] audit: type=1800 audit(1575374684.987:26): pid=8172 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="mcstrans" dev="sda1" ino=2457 res=0 [ 43.332467][ T23] audit: type=1800 audit(1575374684.987:27): pid=8172 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="restorecond" dev="sda1" ino=2436 res=0 [....] Starting periodic command scheduler: cron[?25l[?1c7[ ok 8[?25h[?0c. [....] Starting OpenBSD Secure Shell server: sshd[?25l[?1c7[ ok 8[?25h[?0c. Debian GNU/Linux 7 syzkaller ttyS0 Warning: Permanently added '10.128.0.25' (ECDSA) to the list of known hosts. 2019/12/03 12:04:55 fuzzer started 2019/12/03 12:04:56 dialing manager at 10.128.0.26:45711 2019/12/03 12:04:57 syscalls: 2689 2019/12/03 12:04:57 code coverage: enabled 2019/12/03 12:04:57 comparison tracing: enabled 2019/12/03 12:04:57 extra coverage: extra coverage is not supported by the kernel 2019/12/03 12:04:57 setuid sandbox: enabled 2019/12/03 12:04:57 namespace sandbox: enabled 2019/12/03 12:04:57 Android sandbox: /sys/fs/selinux/policy does not exist 2019/12/03 12:04:57 fault injection: enabled 2019/12/03 12:04:57 leak checking: CONFIG_DEBUG_KMEMLEAK is not enabled 2019/12/03 12:04:57 net packet injection: enabled 2019/12/03 12:04:57 net device setup: enabled 2019/12/03 12:04:57 concurrency sanitizer: /sys/kernel/debug/kcsan does not exist 2019/12/03 12:04:57 devlink PCI setup: PCI device 0000:00:10.0 is not available 12:04:58 executing program 0: r0 = socket(0x10, 0x3, 0x0) sendmsg$nl_route(r0, &(0x7f0000000240)={0x0, 0x0, &(0x7f0000000200)={&(0x7f0000000380)=@ipv4_deladdr={0x18, 0x10, 0x1}, 0x18}}, 0x0) 12:04:58 executing program 1: r0 = getpid() sched_setscheduler(r0, 0x5, &(0x7f0000000380)) perf_event_open(&(0x7f000001d000)={0x1, 0x70, 0x0, 0x0, 0x0, 0x0, 0x0, 0x7f, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_bp={0x0}}, 0x0, 0xffffffffffffffff, 0xffffffffffffffff, 0x0) r1 = openat$kvm(0xffffffffffffff9c, &(0x7f0000000040)='/dev/kvm\x00', 0x0, 0x0) r2 = ioctl$KVM_CREATE_VM(r1, 0xae01, 0x0) syz_kvm_setup_cpu$x86(0xffffffffffffffff, 0xffffffffffffffff, &(0x7f0000000000/0x18000)=nil, &(0x7f00000008c0)=[@text64={0x40, &(0x7f0000000240)="40da3c7248b80a000000000000000f23d00f21f8351000000d0f23f866ba4100b092eec4e1fe12dd644b0fc71e0fc4a6179000006e66b800000f00d8463b779f66b82f018ed8c48149d326", 0x17}], 0x1, 0x0, 0x0, 0x0) r3 = ioctl$KVM_CREATE_VCPU(r2, 0xae41, 0x0) ioctl$KVM_SET_USER_MEMORY_REGION(r2, 0x4020ae46, &(0x7f0000bf7000)={0x0, 0x0, 0x0, 0x2000, &(0x7f0000000000/0x2000)=nil}) ioctl$KVM_SET_REGS(r3, 0x4090ae82, &(0x7f0000000380)={[0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x4cb]}) ioctl$KVM_RUN(r3, 0xae80, 0x0) rt_tgsigqueueinfo(0x0, 0x0, 0x0, &(0x7f00000001c0)={0x24, 0x0, 0x80000001}) ioctl$KVM_RUN(r3, 0xae80, 0x0) syzkaller login: [ 56.529748][ T8336] IPVS: ftp: loaded support on port[0] = 21 12:04:58 executing program 2: r0 = add_key$user(&(0x7f0000000280)='user\x00', &(0x7f0000000000)={'syz'}, &(0x7f0000000240)='X', 0x1, 0xfffffffffffffffe) prlimit64(0x0, 0x0, 0x0, &(0x7f0000000340)) openat$cgroup_ro(0xffffffffffffffff, &(0x7f0000000100)='cpuacct.usage_percpu_user\x00', 0x0, 0x0) r1 = add_key$user(&(0x7f0000000200)='user\x00', &(0x7f00000005c0)={'syz'}, &(0x7f00000000c0), 0x390, 0xfffffffffffffffd) keyctl$dh_compute(0x17, &(0x7f0000000080)={r0, r1, r1}, 0x0, 0x0, &(0x7f00000001c0)={&(0x7f0000000040)={'crct10dif\x00'}}) [ 56.692536][ T8336] chnl_net:caif_netlink_parms(): no params data found [ 56.726170][ T8339] IPVS: ftp: loaded support on port[0] = 21 [ 56.825771][ T8336] bridge0: port 1(bridge_slave_0) entered blocking state [ 56.837082][ T8336] bridge0: port 1(bridge_slave_0) entered disabled state [ 56.845161][ T8336] device bridge_slave_0 entered promiscuous mode [ 56.854408][ T8336] bridge0: port 2(bridge_slave_1) entered blocking state [ 56.862282][ T8336] bridge0: port 2(bridge_slave_1) entered disabled state [ 56.870317][ T8336] device bridge_slave_1 entered promiscuous mode [ 56.893538][ T8336] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 56.905968][ T8336] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 56.940489][ T8341] IPVS: ftp: loaded support on port[0] = 21 [ 56.960936][ T8336] team0: Port device team_slave_0 added [ 56.980713][ T8336] team0: Port device team_slave_1 added 12:04:58 executing program 3: clone(0x54041bc, 0x0, 0xfffffffffffffffe, 0x0, 0xffffffffffffffff) r0 = getpid() rt_tgsigqueueinfo(r0, r0, 0x16, &(0x7f0000000000)) ptrace(0x10, r0) ptrace$getregset(0x4205, r0, 0x2, &(0x7f0000000100)={0x0, 0x10}) [ 57.069841][ T8336] device hsr_slave_0 entered promiscuous mode [ 57.117479][ T8336] device hsr_slave_1 entered promiscuous mode [ 57.216580][ T8339] chnl_net:caif_netlink_parms(): no params data found [ 57.226223][ T8344] IPVS: ftp: loaded support on port[0] = 21 12:04:59 executing program 4: r0 = socket$inet6_sctp(0xa, 0x5, 0x84) setsockopt$inet_sctp6_SCTP_EVENTS(r0, 0x84, 0xb, &(0x7f00000001c0)={0x0, 0x84}, 0xb) shutdown(r0, 0x0) getsockopt$inet_sctp6_SCTP_SOCKOPT_CONNECTX3(r0, 0x84, 0x6f, &(0x7f0000000140)={0x0, 0x10, &(0x7f0000000080)=[@in={0x2, 0x0, @remote}]}, &(0x7f0000000180)=0x10) socketpair(0x1e, 0x1, 0x0, &(0x7f0000000140)={0x0, 0x0}) close(r2) socket$inet6_sctp(0xa, 0x10000000005, 0x84) getsockopt$inet_sctp6_SCTP_DEFAULT_SEND_PARAM(r2, 0x84, 0xa, &(0x7f0000000140)={0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, r1}, &(0x7f0000000180)=0xb0) [ 57.360869][ T8336] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 57.454014][ T8336] netdevsim netdevsim0 netdevsim1: renamed from eth1 12:04:59 executing program 5: r0 = io_uring_setup(0x40000000e, &(0x7f00000005c0)={0x0, 0x0, 0x0, 0x0, 0x0, [], {0x0, 0x0, 0x0, 0x0, 0x0, 0x2}}) ppoll(&(0x7f0000000000)=[{r0}], 0x1, &(0x7f0000000040)={0x0, 0x989680}, 0x0, 0x0) [ 57.561064][ T8336] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 57.645250][ T8339] bridge0: port 1(bridge_slave_0) entered blocking state [ 57.652613][ T8339] bridge0: port 1(bridge_slave_0) entered disabled state [ 57.661521][ T8339] device bridge_slave_0 entered promiscuous mode [ 57.669525][ T8339] bridge0: port 2(bridge_slave_1) entered blocking state [ 57.676584][ T8339] bridge0: port 2(bridge_slave_1) entered disabled state [ 57.684766][ T8339] device bridge_slave_1 entered promiscuous mode [ 57.704720][ T8349] IPVS: ftp: loaded support on port[0] = 21 [ 57.712214][ T8336] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 57.772309][ T8339] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 57.784233][ T8339] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 57.824730][ T8347] IPVS: ftp: loaded support on port[0] = 21 [ 57.870748][ T8339] team0: Port device team_slave_0 added [ 57.881234][ T8339] team0: Port device team_slave_1 added [ 57.889082][ T8344] chnl_net:caif_netlink_parms(): no params data found [ 57.898054][ T8341] chnl_net:caif_netlink_parms(): no params data found [ 57.965503][ T8336] 8021q: adding VLAN 0 to HW filter on device bond0 [ 58.019657][ T8339] device hsr_slave_0 entered promiscuous mode [ 58.057373][ T8339] device hsr_slave_1 entered promiscuous mode [ 58.097398][ T8339] debugfs: Directory 'hsr0' with parent '/' already present! [ 58.136346][ T8344] bridge0: port 1(bridge_slave_0) entered blocking state [ 58.144894][ T8344] bridge0: port 1(bridge_slave_0) entered disabled state [ 58.153289][ T8344] device bridge_slave_0 entered promiscuous mode [ 58.163313][ T8344] bridge0: port 2(bridge_slave_1) entered blocking state [ 58.171093][ T8344] bridge0: port 2(bridge_slave_1) entered disabled state [ 58.178983][ T8344] device bridge_slave_1 entered promiscuous mode [ 58.194521][ T8341] bridge0: port 1(bridge_slave_0) entered blocking state [ 58.204844][ T8341] bridge0: port 1(bridge_slave_0) entered disabled state [ 58.215018][ T8341] device bridge_slave_0 entered promiscuous mode [ 58.224915][ T8341] bridge0: port 2(bridge_slave_1) entered blocking state [ 58.232583][ T8341] bridge0: port 2(bridge_slave_1) entered disabled state [ 58.240381][ T8341] device bridge_slave_1 entered promiscuous mode [ 58.259288][ T8344] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 58.271524][ T8344] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 58.303575][ T8344] team0: Port device team_slave_0 added [ 58.314936][ T8353] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 58.325138][ T8353] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 58.344551][ T8336] 8021q: adding VLAN 0 to HW filter on device team0 [ 58.360638][ T8341] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 58.372326][ T8341] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 58.383605][ T8344] team0: Port device team_slave_1 added [ 58.399831][ T8353] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 58.408790][ T8353] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 58.417803][ T8353] bridge0: port 1(bridge_slave_0) entered blocking state [ 58.424970][ T8353] bridge0: port 1(bridge_slave_0) entered forwarding state [ 58.433767][ T8353] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 58.469292][ T8339] netdevsim netdevsim1 netdevsim0: renamed from eth0 [ 58.513112][ T8339] netdevsim netdevsim1 netdevsim1: renamed from eth1 [ 58.569736][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 58.578888][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 58.587424][ T44] bridge0: port 2(bridge_slave_1) entered blocking state [ 58.594472][ T44] bridge0: port 2(bridge_slave_1) entered forwarding state [ 58.602121][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 58.610900][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 58.619550][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 58.628717][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 58.637125][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 58.646013][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 58.655702][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 58.664025][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 58.672356][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 58.680629][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 58.738836][ T8344] device hsr_slave_0 entered promiscuous mode [ 58.777437][ T8344] device hsr_slave_1 entered promiscuous mode [ 58.807146][ T8344] debugfs: Directory 'hsr0' with parent '/' already present! [ 58.816472][ T8341] team0: Port device team_slave_0 added [ 58.822610][ T8339] netdevsim netdevsim1 netdevsim2: renamed from eth2 [ 58.890042][ T8336] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 58.900075][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 58.914319][ T8349] chnl_net:caif_netlink_parms(): no params data found [ 58.925776][ T8341] team0: Port device team_slave_1 added [ 58.941294][ T8339] netdevsim netdevsim1 netdevsim3: renamed from eth3 [ 59.019435][ T8341] device hsr_slave_0 entered promiscuous mode [ 59.057394][ T8341] device hsr_slave_1 entered promiscuous mode [ 59.097209][ T8341] debugfs: Directory 'hsr0' with parent '/' already present! [ 59.134801][ T8347] chnl_net:caif_netlink_parms(): no params data found [ 59.153997][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 59.162186][ T44] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 59.171586][ T8336] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 59.216699][ T8341] netdevsim netdevsim2 netdevsim0: renamed from eth0 [ 59.326191][ T8341] netdevsim netdevsim2 netdevsim1: renamed from eth1 [ 164.396947][ C0] rcu: INFO: rcu_preempt self-detected stall on CPU [ 164.403895][ C0] rcu: 0-...!: (1 GPs behind) idle=072/1/0x4000000000000002 softirq=11155/11156 fqs=37 [ 164.414050][ C0] (t=10501 jiffies g=6041 q=152) [ 164.419079][ C0] rcu: rcu_preempt kthread starved for 10428 jiffies! g6041 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=1 [ 164.430285][ C0] rcu: RCU grace-period kthread stack dump: [ 164.436249][ C0] rcu_preempt R running task 29104 10 2 0x80004000 [ 164.444186][ C0] Call Trace: [ 164.447508][ C0] __schedule+0x9a0/0xcc0 [ 164.452032][ C0] schedule+0x181/0x210 [ 164.456248][ C0] schedule_timeout+0x14f/0x240 [ 164.461118][ C0] ? run_local_timers+0x120/0x120 [ 164.466157][ C0] rcu_gp_kthread+0xed8/0x1770 [ 164.470919][ C0] kthread+0x332/0x350 [ 164.474978][ C0] ? rcu_report_qs_rsp+0x140/0x140 [ 164.480077][ C0] ? kthread_blkcg+0xe0/0xe0 [ 164.484656][ C0] ret_from_fork+0x24/0x30 [ 164.489089][ C0] NMI backtrace for cpu 0 [ 164.493409][ C0] CPU: 0 PID: 7 Comm: kworker/u4:0 Not tainted 5.4.0-syzkaller #0 [ 164.501188][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 164.511250][ C0] Workqueue: 0x0 (bat_events) [ 164.515985][ C0] Call Trace: [ 164.519258][ C0] [ 164.522086][ C0] dump_stack+0x1fb/0x318 [ 164.526527][ C0] nmi_cpu_backtrace+0xaf/0x1a0 [ 164.531390][ C0] ? nmi_trigger_cpumask_backtrace+0x16d/0x290 [ 164.537544][ C0] ? arch_trigger_cpumask_backtrace+0x20/0x20 [ 164.543601][ C0] nmi_trigger_cpumask_backtrace+0x174/0x290 [ 164.549571][ C0] arch_trigger_cpumask_backtrace+0x10/0x20 [ 164.555448][ C0] rcu_dump_cpu_stacks+0x15a/0x220 [ 164.560541][ C0] rcu_sched_clock_irq+0xe25/0x1ad0 [ 164.565717][ C0] ? trace_hardirqs_off+0x74/0x80 [ 164.570713][ C0] update_process_times+0x12d/0x180 [ 164.575886][ C0] tick_sched_timer+0x263/0x420 [ 164.580715][ C0] ? tick_setup_sched_timer+0x3d0/0x3d0 [ 164.586344][ C0] __hrtimer_run_queues+0x403/0x840 [ 164.591550][ C0] hrtimer_interrupt+0x38c/0xda0 [ 164.596470][ C0] ? debug_smp_processor_id+0x9/0x20 [ 164.601743][ C0] smp_apic_timer_interrupt+0x109/0x280 [ 164.607264][ C0] apic_timer_interrupt+0xf/0x20 [ 164.612172][ C0] [ 164.615088][ C0] RIP: 0010:mod_memcg_page_state+0x16/0x190 [ 164.620955][ C0] Code: 48 83 c4 10 5b 41 5c 41 5d 41 5e 41 5f 5d c3 0f 1f 44 00 00 55 48 89 e5 41 57 41 56 41 54 53 41 89 f6 48 89 fb e8 da 28 2e 00 <48> 83 c3 38 48 89 d8 48 c1 e8 03 49 bc 00 00 00 00 00 fc ff df 42 [ 164.640554][ C0] RSP: 0018:ffffc90000cdfc00 EFLAGS: 00000293 ORIG_RAX: ffffffffffffff13 [ 164.648950][ C0] RAX: ffffffff81487326 RBX: ffffea0001b13180 RCX: ffff8880a9da01c0 [ 164.656905][ C0] RDX: 0000000000000000 RSI: 00000000fffffffc RDI: ffffea0001b13180 [ 164.664853][ C0] RBP: ffffc90000cdfc20 R08: dffffc0000000000 R09: fffffbfff120248a [ 164.672811][ C0] R10: fffffbfff120248a R11: 0000000000000000 R12: ffff888094ce35a0 [ 164.680764][ C0] R13: dffffc0000000000 R14: 00000000fffffffc R15: ffff88809348d668 [ 164.688721][ C0] ? mod_memcg_page_state+0x16/0x190 [ 164.693996][ C0] free_thread_stack+0x168/0x590 [ 164.698911][ C0] put_task_stack+0xa3/0x130 [ 164.703483][ C0] finish_task_switch+0x3f1/0x550 [ 164.708484][ C0] __schedule+0x9a8/0xcc0 [ 164.712805][ C0] schedule+0x181/0x210 [ 164.716950][ C0] worker_thread+0x10d6/0x1630 [ 164.721719][ C0] kthread+0x332/0x350 [ 164.725762][ C0] ? rcu_lock_release+0x30/0x30 [ 164.730587][ C0] ? kthread_blkcg+0xe0/0xe0 [ 164.735152][ C0] ret_from_fork+0x24/0x30