[....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [ 43.722344][ T23] audit: type=1800 audit(1575405454.267:25): pid=8088 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="cron" dev="sda1" ino=2414 res=0 [ 43.743234][ T23] audit: type=1800 audit(1575405454.267:26): pid=8088 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="mcstrans" dev="sda1" ino=2457 res=0 [ 43.775265][ T23] audit: type=1800 audit(1575405454.277:27): pid=8088 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.10.48' (ECDSA) to the list of known hosts. 2019/12/03 20:37:45 fuzzer started 2019/12/03 20:37:46 dialing manager at 10.128.0.26:42111 2019/12/03 20:37:46 syscalls: 2689 2019/12/03 20:37:46 code coverage: enabled 2019/12/03 20:37:46 comparison tracing: enabled 2019/12/03 20:37:46 extra coverage: extra coverage is not supported by the kernel 2019/12/03 20:37:46 setuid sandbox: enabled 2019/12/03 20:37:46 namespace sandbox: enabled 2019/12/03 20:37:46 Android sandbox: /sys/fs/selinux/policy does not exist 2019/12/03 20:37:46 fault injection: enabled 2019/12/03 20:37:46 leak checking: CONFIG_DEBUG_KMEMLEAK is not enabled 2019/12/03 20:37:46 net packet injection: enabled 2019/12/03 20:37:46 net device setup: enabled 2019/12/03 20:37:46 concurrency sanitizer: /sys/kernel/debug/kcsan does not exist 2019/12/03 20:37:46 devlink PCI setup: PCI device 0000:00:10.0 is not available 20:37:48 executing program 0: socketpair$unix(0x1, 0x5, 0x0, &(0x7f0000000000)={0xffffffffffffffff, 0xffffffffffffffff}) setsockopt$SO_ATTACH_FILTER(r0, 0x1, 0x1a, &(0x7f0000ab9ff0)={0x2, &(0x7f000039a000)=[{0x30, 0x0, 0x0, 0xfffff028}, {0x6}]}, 0x10) 20:37:48 executing program 1: rt_tgsigqueueinfo(0x0, 0x0, 0x0, &(0x7f0000000040)={0x0, 0x0, 0x80}) syzkaller login: [ 57.647262][ T8254] IPVS: ftp: loaded support on port[0] = 21 [ 57.789996][ T8254] chnl_net:caif_netlink_parms(): no params data found [ 57.836117][ T8254] bridge0: port 1(bridge_slave_0) entered blocking state [ 57.845394][ T8254] bridge0: port 1(bridge_slave_0) entered disabled state [ 57.854525][ T8254] device bridge_slave_0 entered promiscuous mode [ 57.864488][ T8254] bridge0: port 2(bridge_slave_1) entered blocking state [ 57.872018][ T8254] bridge0: port 2(bridge_slave_1) entered disabled state [ 57.881272][ T8254] device bridge_slave_1 entered promiscuous mode [ 57.912132][ T8254] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 57.924827][ T8254] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 57.954712][ T8254] team0: Port device team_slave_0 added 20:37:48 executing program 2: r0 = socket$nl_route(0x10, 0x3, 0x0) r1 = socket$kcm(0x29, 0x5, 0x0) ioctl$ifreq_SIOCGIFINDEX_team(r1, 0x8933, &(0x7f0000000100)={'team0\x00', 0x0}) sendmsg$nl_route(r0, &(0x7f00000002c0)={0x0, 0x0, &(0x7f0000000300)={&(0x7f0000000000)=@ipv6_newaddr={0x2c, 0x28, 0x1, 0x0, 0x0, {0xa, 0x0, 0x0, 0x0, r2}, [@IFA_CACHEINFO={0x14, 0x6, {0x2}}]}, 0x2c}}, 0x0) [ 57.963499][ T8254] team0: Port device team_slave_1 added [ 57.976347][ T8257] IPVS: ftp: loaded support on port[0] = 21 [ 58.031100][ T8254] device hsr_slave_0 entered promiscuous mode [ 58.068665][ T8254] device hsr_slave_1 entered promiscuous mode [ 58.174687][ T8259] IPVS: ftp: loaded support on port[0] = 21 20:37:48 executing program 3: write$cgroup_type(0xffffffffffffffff, &(0x7f0000000000)='threaded\x00', 0x9) r0 = openat$kvm(0xffffffffffffff9c, &(0x7f00000006c0)='/dev/kvm\x00', 0x0, 0x0) r1 = socket$inet_smc(0x2b, 0x1, 0x0) setsockopt$sock_int(r1, 0x1, 0x0, 0x0, 0x0) r2 = ioctl$KVM_CREATE_VM(r0, 0xae01, 0x0) write$binfmt_misc(0xffffffffffffffff, 0x0, 0x0) syz_emit_ethernet(0x66, &(0x7f0000000080)={@link_local, @link_local={0x1, 0x80, 0xc2, 0x689, 0x3}, [], {@ipv6={0x86dd, {0x0, 0x6, 'v`Q', 0x30, 0x3a, 0x0, @remote={0xfe, 0x80, [0x3, 0x543, 0x700, 0x5, 0x50000000000000d, 0x8848000000f0ffff], 0xffffffffffffffff}, @mcast2={0xff, 0x2, [0x0, 0xfffffffffffff000]}, {[], @icmpv6=@dest_unreach={0xffffff86, 0x0, 0x0, 0x0, [0x7, 0xffffca88], {0x0, 0x6, "c5961e", 0x0, 0x0, 0x0, @mcast1={0x18, 0x4, [0x0, 0x80ffffff, 0x28, 0x0, 0x0, 0x0, 0x18, 0x3, 0x0, 0x0, 0x5]}, @mcast2={0x11, 0x5}}}}}}}}, 0x0) ioctl$int_in(0xffffffffffffffff, 0x0, 0x0) openat$sequencer2(0xffffffffffffff9c, 0x0, 0x10000, 0x0) sync_file_range(0xffffffffffffffff, 0x40, 0x0, 0x0) r3 = ioctl$KVM_CREATE_VCPU(r2, 0xae41, 0x0) syz_kvm_setup_cpu$x86(r2, 0xffffffffffffffff, &(0x7f0000fe8000/0x18000)=nil, 0x0, 0x0, 0x0, 0x0, 0xfffffdac) syz_kvm_setup_cpu$x86(0xffffffffffffffff, r3, &(0x7f0000fe8000/0x18000)=nil, &(0x7f0000000140)=[@text64={0x40, &(0x7f0000000100)="460f300f07c483614804ee08440f20c03506000000440f22c0c402f93473230f09f20f013cb9b805000000b9c00000000f01d90fc728c4c1f9e79f2e000000", 0x3f}], 0x1, 0x0, 0x0, 0x0) ioctl$KVM_RUN(r3, 0xae80, 0x0) r4 = socket$inet6_tcp(0xa, 0x1, 0x0) r5 = dup2(r4, r4) ioctl$PERF_EVENT_IOC_ENABLE(r5, 0x8912, 0x400200) [ 58.245996][ T8254] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 58.300529][ T8254] netdevsim netdevsim0 netdevsim1: renamed from eth1 [ 58.371175][ T8254] netdevsim netdevsim0 netdevsim2: renamed from eth2 20:37:49 executing program 4: shmget$private(0x0, 0x4000, 0x0, &(0x7f0000ffb000/0x4000)=nil) shmctl$SHM_INFO(0x0, 0xe, 0x0) shmctl$IPC_SET(0x0, 0x1, 0x0) getgroups(0x0, 0x0) lchown(0x0, 0x0, 0x0) add_key$keyring(&(0x7f0000000280)='keyring\x00', 0x0, 0x0, 0x0, 0xffffffffffffffff) r0 = socket$inet_udplite(0x2, 0x2, 0x88) getsockopt$sock_cred(r0, 0x1, 0x11, &(0x7f0000000000)={0x0, 0x0}, &(0x7f0000000300)=0xc) keyctl$get_persistent(0x3, r1, 0x0) request_key(&(0x7f00000002c0)='user\x00', &(0x7f0000000000)={'syz'}, &(0x7f0000000280)='user}eth1\x00', 0x0) [ 58.440710][ T8254] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 58.594711][ T8254] bridge0: port 2(bridge_slave_1) entered blocking state [ 58.602191][ T8254] bridge0: port 2(bridge_slave_1) entered forwarding state [ 58.610479][ T8254] bridge0: port 1(bridge_slave_0) entered blocking state [ 58.617551][ T8254] bridge0: port 1(bridge_slave_0) entered forwarding state [ 58.639233][ T8261] IPVS: ftp: loaded support on port[0] = 21 [ 58.662687][ T8257] chnl_net:caif_netlink_parms(): no params data found [ 58.820057][ T2946] bridge0: port 1(bridge_slave_0) entered disabled state [ 58.829625][ T2946] bridge0: port 2(bridge_slave_1) entered disabled state 20:37:49 executing program 5: perf_event_open(&(0x7f000001d000)={0x0, 0x70, 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, 0x0, 0x0, 0x0, 0x0, 0x0, 0x0, @perf_bp={&(0x7f0000000140)}}, 0x0, 0x0, 0xffffffffffffffff, 0x0) syz_open_dev$vcsa(&(0x7f0000000240)='/dev/vcsa#\x00', 0x3, 0x0) r0 = syz_open_dev$evdev(0xfffffffffffffffd, 0x0, 0x0) readv(r0, &(0x7f0000019fe0)=[{&(0x7f00008ec000)=""/219, 0xfa4}], 0x10000000000003c3) [ 58.871976][ T8266] IPVS: ftp: loaded support on port[0] = 21 [ 58.885368][ T8259] chnl_net:caif_netlink_parms(): no params data found [ 58.910115][ T8254] 8021q: adding VLAN 0 to HW filter on device bond0 [ 58.920040][ T8257] bridge0: port 1(bridge_slave_0) entered blocking state [ 58.927121][ T8257] bridge0: port 1(bridge_slave_0) entered disabled state [ 58.936465][ T8257] device bridge_slave_0 entered promiscuous mode [ 58.954413][ T8257] bridge0: port 2(bridge_slave_1) entered blocking state [ 58.963374][ T8257] bridge0: port 2(bridge_slave_1) entered disabled state [ 58.972654][ T8257] device bridge_slave_1 entered promiscuous mode [ 58.996444][ T8254] 8021q: adding VLAN 0 to HW filter on device team0 [ 59.024574][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 59.033759][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 59.062007][ T8257] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 59.086079][ T8269] IPVS: ftp: loaded support on port[0] = 21 [ 59.102132][ T2946] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 59.113679][ T2946] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 59.122090][ T2946] bridge0: port 1(bridge_slave_0) entered blocking state [ 59.129159][ T2946] bridge0: port 1(bridge_slave_0) entered forwarding state [ 59.137612][ T2946] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 59.147235][ T2946] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 59.155712][ T2946] bridge0: port 2(bridge_slave_1) entered blocking state [ 59.162904][ T2946] bridge0: port 2(bridge_slave_1) entered forwarding state [ 59.170955][ T2946] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 59.179834][ T2946] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 59.205038][ T8257] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 59.223429][ T8259] bridge0: port 1(bridge_slave_0) entered blocking state [ 59.230936][ T8259] bridge0: port 1(bridge_slave_0) entered disabled state [ 59.238994][ T8259] device bridge_slave_0 entered promiscuous mode [ 59.265798][ T8259] bridge0: port 2(bridge_slave_1) entered blocking state [ 59.273750][ T8259] bridge0: port 2(bridge_slave_1) entered disabled state [ 59.282122][ T8259] device bridge_slave_1 entered promiscuous mode [ 59.300570][ T8259] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 59.313561][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 59.322656][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 59.333138][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 59.341807][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 59.352941][ T8257] team0: Port device team_slave_0 added [ 59.360500][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 59.374713][ T8261] chnl_net:caif_netlink_parms(): no params data found [ 59.384595][ T8259] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 59.410344][ T8257] team0: Port device team_slave_1 added [ 59.441603][ T8259] team0: Port device team_slave_0 added [ 59.511864][ T8257] device hsr_slave_0 entered promiscuous mode [ 59.578409][ T8257] device hsr_slave_1 entered promiscuous mode [ 59.618572][ T8257] debugfs: Directory 'hsr0' with parent '/' already present! [ 59.642352][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 59.650928][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 59.659714][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 59.667941][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 59.677588][ T8259] team0: Port device team_slave_1 added [ 59.685390][ T8254] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 59.706418][ T8266] chnl_net:caif_netlink_parms(): no params data found [ 59.791200][ T8259] device hsr_slave_0 entered promiscuous mode [ 59.828433][ T8259] device hsr_slave_1 entered promiscuous mode [ 59.888770][ T8259] debugfs: Directory 'hsr0' with parent '/' already present! [ 59.960975][ T8266] bridge0: port 1(bridge_slave_0) entered blocking state [ 59.968404][ T8266] bridge0: port 1(bridge_slave_0) entered disabled state [ 59.976059][ T8266] device bridge_slave_0 entered promiscuous mode [ 59.985411][ T8266] bridge0: port 2(bridge_slave_1) entered blocking state [ 59.992539][ T8266] bridge0: port 2(bridge_slave_1) entered disabled state [ 60.000507][ T8266] device bridge_slave_1 entered promiscuous mode [ 60.014757][ T8259] netdevsim netdevsim2 netdevsim0: renamed from eth0 [ 60.092602][ T8257] netdevsim netdevsim1 netdevsim0: renamed from eth0 [ 60.139659][ T8257] netdevsim netdevsim1 netdevsim1: renamed from eth1 [ 60.194669][ T8261] bridge0: port 1(bridge_slave_0) entered blocking state [ 60.201914][ T8261] bridge0: port 1(bridge_slave_0) entered disabled state [ 60.209967][ T8261] device bridge_slave_0 entered promiscuous mode [ 60.217430][ T8261] bridge0: port 2(bridge_slave_1) entered blocking state [ 60.225065][ T8261] bridge0: port 2(bridge_slave_1) entered disabled state [ 60.233119][ T8261] device bridge_slave_1 entered promiscuous mode [ 60.239963][ T8259] netdevsim netdevsim2 netdevsim1: renamed from eth1 [ 60.292766][ T8259] netdevsim netdevsim2 netdevsim2: renamed from eth2 [ 60.339292][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 60.346732][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 60.355479][ T8254] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 60.363985][ T8257] netdevsim netdevsim1 netdevsim2: renamed from eth2 [ 60.403936][ T8257] netdevsim netdevsim1 netdevsim3: renamed from eth3 [ 60.445106][ T8259] netdevsim netdevsim2 netdevsim3: renamed from eth3 [ 60.504830][ T8266] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 60.526691][ T8261] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 60.541025][ T8266] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 60.552536][ T8261] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 60.616434][ T8261] team0: Port device team_slave_0 added [ 60.638879][ T8269] chnl_net:caif_netlink_parms(): no params data found [ 60.670799][ T8261] team0: Port device team_slave_1 added [ 60.677954][ T8266] team0: Port device team_slave_0 added [ 60.710814][ T8259] 8021q: adding VLAN 0 to HW filter on device bond0 [ 60.725614][ T8259] 8021q: adding VLAN 0 to HW filter on device team0 [ 60.753567][ T8259] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 60.764072][ T8259] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 60.789834][ T8259] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 60.814576][ T8266] team0: Port device team_slave_1 added [ 165.687969][ C0] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 165.694966][ C0] (detected by 0, t=10502 jiffies, g=6125, q=498) [ 165.701453][ C0] rcu: All QSes seen, last rcu_preempt kthread activity 10503 (4294953689-4294943186), jiffies_till_next_fqs=1, root ->qsmask 0x0 [ 165.714965][ C0] kworker/u4:1 R running task 26448 21 2 0x80004008 [ 165.722927][ C0] Workqueue: 0x0 (bat_events) [ 165.727684][ C0] Call Trace: [ 165.730960][ C0] [ 165.733827][ C0] sched_show_task+0x40f/0x560 [ 165.738589][ C0] rcu_sched_clock_irq+0x1861/0x1ad0 [ 165.743876][ C0] update_process_times+0x12d/0x180 [ 165.749067][ C0] tick_sched_timer+0x263/0x420 [ 165.753912][ C0] ? tick_setup_sched_timer+0x3d0/0x3d0 [ 165.759453][ C0] __hrtimer_run_queues+0x403/0x840 [ 165.764654][ C0] hrtimer_interrupt+0x38c/0xda0 [ 165.769608][ C0] ? debug_smp_processor_id+0x9/0x20 [ 165.774887][ C0] smp_apic_timer_interrupt+0x109/0x280 [ 165.780420][ C0] apic_timer_interrupt+0xf/0x20 [ 165.785340][ C0] [ 165.788273][ C0] RIP: 0010:__memcg_kmem_uncharge+0x28/0x2e0 [ 165.794239][ C0] Code: 00 00 55 48 89 e5 41 57 41 56 41 55 41 54 53 50 89 f3 49 89 fc 48 b8 00 00 00 00 00 fc ff df 4c 8d 77 38 4d 89 f5 49 c1 ed 03 <41> 80 7c 05 00 00 74 08 4c 89 f7 e8 d8 f4 fa ff 4d 8b 3e b8 01 00 [ 165.813830][ C0] RSP: 0018:ffffc90000dd7bf0 EFLAGS: 00000a02 ORIG_RAX: ffffffffffffff13 [ 165.822226][ C0] RAX: dffffc0000000000 RBX: 0000000000000000 RCX: ffff8880a9ffa580 [ 165.830204][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffffea0001b1b600 [ 165.838199][ C0] RBP: ffffc90000dd7c20 R08: dffffc0000000000 R09: fffffbfff12877ed [ 165.846603][ C0] R10: fffffbfff12877ed R11: 0000000000000000 R12: ffffea0001b1b600 [ 165.854574][ C0] R13: 1ffffd40003636c7 R14: ffffea0001b1b638 R15: ffff88809892d8a8 [ 165.862566][ C0] ? free_thread_stack+0x124/0x590 [ 165.867666][ C0] free_thread_stack+0x12e/0x590 [ 165.872596][ C0] put_task_stack+0xa3/0x130 [ 165.877195][ C0] finish_task_switch+0x3f1/0x550 [ 165.882230][ C0] __schedule+0x9a8/0xcc0 [ 165.886570][ C0] schedule+0x181/0x210 [ 165.890724][ C0] worker_thread+0x10d6/0x1630 [ 165.895504][ C0] kthread+0x332/0x350 [ 165.899563][ C0] ? rcu_lock_release+0x30/0x30 [ 165.904410][ C0] ? kthread_blkcg+0xe0/0xe0 [ 165.908991][ C0] ret_from_fork+0x24/0x30 [ 165.915411][ C0] rcu: rcu_preempt kthread starved for 10524 jiffies! g6125 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=1 [ 165.926665][ C0] rcu: RCU grace-period kthread stack dump: [ 165.932540][ C0] rcu_preempt R running task 29104 10 2 0x80004000 [ 165.940424][ C0] Call Trace: [ 165.943705][ C0] __schedule+0x9a0/0xcc0 [ 165.948032][ C0] schedule+0x181/0x210 [ 165.952179][ C0] schedule_timeout+0x14f/0x240 [ 165.957019][ C0] ? run_local_timers+0x120/0x120 [ 165.962035][ C0] rcu_gp_kthread+0xed8/0x1770 [ 165.966800][ C0] kthread+0x332/0x350 [ 165.970858][ C0] ? rcu_report_qs_rsp+0x140/0x140 [ 165.975965][ C0] ? kthread_blkcg+0xe0/0xe0 [ 165.980542][ C0] ret_from_fork+0x24/0x30