[....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [ 43.689581][ T25] audit: type=1800 audit(1575413978.577:25): pid=8008 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="cron" dev="sda1" ino=2414 res=0 [ 43.709271][ T25] audit: type=1800 audit(1575413978.577:26): pid=8008 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="mcstrans" dev="sda1" ino=2457 res=0 [ 43.729647][ T25] audit: type=1800 audit(1575413978.587:27): pid=8008 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.147' (ECDSA) to the list of known hosts. 2019/12/03 22:59:49 fuzzer started 2019/12/03 22:59:51 dialing manager at 10.128.0.26:42111 2019/12/03 22:59:51 syscalls: 2689 2019/12/03 22:59:51 code coverage: enabled 2019/12/03 22:59:51 comparison tracing: enabled 2019/12/03 22:59:51 extra coverage: extra coverage is not supported by the kernel 2019/12/03 22:59:51 setuid sandbox: enabled 2019/12/03 22:59:51 namespace sandbox: enabled 2019/12/03 22:59:51 Android sandbox: /sys/fs/selinux/policy does not exist 2019/12/03 22:59:51 fault injection: enabled 2019/12/03 22:59:51 leak checking: CONFIG_DEBUG_KMEMLEAK is not enabled 2019/12/03 22:59:51 net packet injection: enabled 2019/12/03 22:59:51 net device setup: enabled 2019/12/03 22:59:51 concurrency sanitizer: /sys/kernel/debug/kcsan does not exist 2019/12/03 22:59:51 devlink PCI setup: PCI device 0000:00:10.0 is not available 22:59:52 executing program 0: perf_event_open(&(0x7f0000000180)={0x2, 0x70, 0xea, 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, 0x4, 0x0, 0x0, @perf_bp={0x0}}, 0x0, 0x0, 0xffffffffffffffff, 0x0) 22:59:52 executing program 1: r0 = syz_open_dev$radio(&(0x7f0000000000)='/dev/radio#\x00', 0x0, 0x2) ioctl$VIDIOC_S_HW_FREQ_SEEK(r0, 0x40305652, &(0x7f00000001c0)={0x0, 0x1, 0x0, 0x0, 0x0, 0xffff, 0x6ae0}) syzkaller login: [ 57.498748][ T8171] IPVS: ftp: loaded support on port[0] = 21 [ 57.611977][ T8173] IPVS: ftp: loaded support on port[0] = 21 [ 57.682967][ T8171] chnl_net:caif_netlink_parms(): no params data found [ 57.718372][ T8171] bridge0: port 1(bridge_slave_0) entered blocking state [ 57.726031][ T8171] bridge0: port 1(bridge_slave_0) entered disabled state 22:59:52 executing program 2: perf_event_open(&(0x7f0000000040)={0x2, 0x70, 0x5aeb, 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={0x0}}, 0x0, 0x0, 0xffffffffffffffff, 0x0) r0 = socket$nl_crypto(0x10, 0x3, 0x15) sendmsg$nl_crypto(r0, &(0x7f0000000180)={0x0, 0x0, &(0x7f0000000140)={&(0x7f0000000000)=@alg={0xe0, 0x10, 0x1, 0x0, 0x0, {{'drbg_nopr_hmac_sha1\x00'}}}, 0xe0}}, 0x0) [ 57.734437][ T8171] device bridge_slave_0 entered promiscuous mode [ 57.745391][ T8171] bridge0: port 2(bridge_slave_1) entered blocking state [ 57.752509][ T8171] bridge0: port 2(bridge_slave_1) entered disabled state [ 57.760537][ T8171] device bridge_slave_1 entered promiscuous mode [ 57.787084][ T8171] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 57.809480][ T8171] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 57.910082][ T8171] team0: Port device team_slave_0 added [ 57.924997][ T8171] team0: Port device team_slave_1 added [ 57.948479][ T8177] IPVS: ftp: loaded support on port[0] = 21 [ 57.963707][ T8173] chnl_net:caif_netlink_parms(): no params data found 22:59:52 executing program 3: r0 = socket$alg(0x26, 0x5, 0x0) bind$alg(r0, &(0x7f0000000080)={0x26, 'skcipher\x00', 0x0, 0x0, 'pcbc(fcrypt)\x00'}, 0x58) setsockopt$ALG_SET_KEY(r0, 0x117, 0x1, &(0x7f0000412ff8)="3665a1ab415b7ac7", 0x8) r1 = socket$inet6(0xa, 0x80003, 0xff) ioctl(r1, 0x1000008912, &(0x7f0000000080)="0800b5055e0bcfe87b2071") r2 = accept(r0, 0x0, 0x0) sendmmsg$alg(r2, &(0x7f0000000540)=[{0x0, 0x0, 0x0, 0x0, &(0x7f0000000500)=[@op={0x18, 0x117, 0x3, 0x1}], 0x18}], 0x1, 0x0) sendmsg$NBD_CMD_STATUS(r2, &(0x7f00000004c0)={0x0, 0x0, &(0x7f0000000480)={&(0x7f00000003c0)=ANY=[@ANYBLOB=' \x00\x00\x00', @ANYRES16=0x0, @ANYBLOB="000000000000000000000500000000164dd24a325b360f02b7e972ff0300"/42], 0x20}}, 0x0) recvmsg(r2, &(0x7f000000b680)={0x0, 0x0, &(0x7f000000b600)=[{&(0x7f000000b4c0)=""/5, 0x4}, {&(0x7f000000b500)=""/153, 0x7fffeffb}], 0x2}, 0x0) [ 58.056035][ T8171] device hsr_slave_0 entered promiscuous mode [ 58.103628][ T8171] device hsr_slave_1 entered promiscuous mode [ 58.155756][ T8179] IPVS: ftp: loaded support on port[0] = 21 [ 58.247470][ T8173] bridge0: port 1(bridge_slave_0) entered blocking state [ 58.263356][ T8173] bridge0: port 1(bridge_slave_0) entered disabled state [ 58.271075][ T8173] device bridge_slave_0 entered promiscuous mode 22:59:53 executing program 4: r0 = socket$inet6_sctp(0xa, 0x1, 0x84) getsockopt$inet_sctp6_SCTP_STREAM_SCHEDULER(r0, 0x84, 0x7b, &(0x7f0000000080), &(0x7f00000000c0)=0x8) [ 58.314808][ T8173] bridge0: port 2(bridge_slave_1) entered blocking state [ 58.322223][ T8173] bridge0: port 2(bridge_slave_1) entered disabled state [ 58.334670][ T8173] device bridge_slave_1 entered promiscuous mode [ 58.341773][ T8171] netdevsim netdevsim0 netdevsim0: renamed from eth0 [ 58.423721][ T8171] netdevsim netdevsim0 netdevsim1: renamed from eth1 22:59:53 executing program 5: r0 = openat$cuse(0xffffffffffffff9c, &(0x7f0000000000)='/dev/cuse\x00', 0x2, 0x0) pwritev(r0, &(0x7f0000000240)=[{&(0x7f0000000040)="8f806a50ad30d08e36d6cba55e3ac45a", 0x10}], 0x1, 0x0) [ 58.495430][ T8171] netdevsim netdevsim0 netdevsim2: renamed from eth2 [ 58.545487][ T8171] netdevsim netdevsim0 netdevsim3: renamed from eth3 [ 58.601166][ T8173] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 58.621664][ T8182] IPVS: ftp: loaded support on port[0] = 21 [ 58.632352][ T8184] IPVS: ftp: loaded support on port[0] = 21 [ 58.670724][ T8173] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 58.721035][ T8177] chnl_net:caif_netlink_parms(): no params data found [ 58.733168][ T8173] team0: Port device team_slave_0 added [ 58.748179][ T8173] team0: Port device team_slave_1 added [ 58.834964][ T8173] device hsr_slave_0 entered promiscuous mode [ 58.893660][ T8173] device hsr_slave_1 entered promiscuous mode [ 58.953465][ T8173] debugfs: Directory 'hsr0' with parent '/' already present! [ 58.976467][ T8179] chnl_net:caif_netlink_parms(): no params data found [ 59.002204][ T8177] bridge0: port 1(bridge_slave_0) entered blocking state [ 59.010277][ T8177] bridge0: port 1(bridge_slave_0) entered disabled state [ 59.018885][ T8177] device bridge_slave_0 entered promiscuous mode [ 59.027269][ T8177] bridge0: port 2(bridge_slave_1) entered blocking state [ 59.034387][ T8177] bridge0: port 2(bridge_slave_1) entered disabled state [ 59.042049][ T8177] device bridge_slave_1 entered promiscuous mode [ 59.092855][ T8182] chnl_net:caif_netlink_parms(): no params data found [ 59.106067][ T8177] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 59.117124][ T8177] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 59.175476][ T8171] 8021q: adding VLAN 0 to HW filter on device bond0 [ 59.197949][ T8173] netdevsim netdevsim1 netdevsim0: renamed from eth0 [ 59.277965][ T8173] netdevsim netdevsim1 netdevsim1: renamed from eth1 [ 59.328407][ T8177] team0: Port device team_slave_0 added [ 59.339255][ T8179] bridge0: port 1(bridge_slave_0) entered blocking state [ 59.347101][ T8179] bridge0: port 1(bridge_slave_0) entered disabled state [ 59.355680][ T8179] device bridge_slave_0 entered promiscuous mode [ 59.365978][ T8179] bridge0: port 2(bridge_slave_1) entered blocking state [ 59.373051][ T8179] bridge0: port 2(bridge_slave_1) entered disabled state [ 59.381007][ T8179] device bridge_slave_1 entered promiscuous mode [ 59.388996][ T8173] netdevsim netdevsim1 netdevsim2: renamed from eth2 [ 59.448876][ T8177] team0: Port device team_slave_1 added [ 59.455049][ T8182] bridge0: port 1(bridge_slave_0) entered blocking state [ 59.462302][ T8182] bridge0: port 1(bridge_slave_0) entered disabled state [ 59.470777][ T8182] device bridge_slave_0 entered promiscuous mode [ 59.481662][ T3091] IPv6: ADDRCONF(NETDEV_CHANGE): veth1: link becomes ready [ 59.490132][ T3091] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 59.504201][ T8171] 8021q: adding VLAN 0 to HW filter on device team0 [ 59.511337][ T8173] netdevsim netdevsim1 netdevsim3: renamed from eth3 [ 59.569016][ T8182] bridge0: port 2(bridge_slave_1) entered blocking state [ 59.576617][ T8182] bridge0: port 2(bridge_slave_1) entered disabled state [ 59.584950][ T8182] device bridge_slave_1 entered promiscuous mode [ 59.635552][ T8179] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 59.646857][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bridge: link becomes ready [ 59.655694][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 59.664966][ T5] bridge0: port 1(bridge_slave_0) entered blocking state [ 59.672278][ T5] bridge0: port 1(bridge_slave_0) entered forwarding state [ 59.680584][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): bridge0: link becomes ready [ 59.699227][ T8182] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 59.710601][ T8182] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 59.729245][ T8179] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 59.744676][ T3091] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bridge: link becomes ready [ 59.753537][ T3091] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 59.761933][ T3091] bridge0: port 2(bridge_slave_1) entered blocking state [ 59.769006][ T3091] bridge0: port 2(bridge_slave_1) entered forwarding state [ 59.776965][ T3091] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_bond: link becomes ready [ 59.836089][ T8177] device hsr_slave_0 entered promiscuous mode [ 59.893670][ T8177] device hsr_slave_1 entered promiscuous mode [ 59.933416][ T8177] debugfs: Directory 'hsr0' with parent '/' already present! [ 59.968630][ T8179] team0: Port device team_slave_0 added [ 59.976052][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_bond: link becomes ready [ 59.985017][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_team: link becomes ready [ 59.993991][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 60.005445][ T8182] team0: Port device team_slave_0 added [ 60.016102][ T8182] team0: Port device team_slave_1 added [ 60.022313][ T8184] chnl_net:caif_netlink_parms(): no params data found [ 60.044085][ T8179] team0: Port device team_slave_1 added [ 60.051114][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 60.059352][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_team: link becomes ready [ 60.067876][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 60.076426][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0_to_hsr: link becomes ready [ 60.085068][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 60.146059][ T8182] device hsr_slave_0 entered promiscuous mode [ 60.193736][ T8182] device hsr_slave_1 entered promiscuous mode [ 60.233401][ T8182] debugfs: Directory 'hsr0' with parent '/' already present! [ 60.316105][ T8179] device hsr_slave_0 entered promiscuous mode [ 60.373623][ T8179] device hsr_slave_1 entered promiscuous mode [ 60.413299][ T8179] debugfs: Directory 'hsr0' with parent '/' already present! [ 60.426633][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth1_to_hsr: link becomes ready [ 60.436599][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 60.450084][ T8171] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 60.500598][ T8171] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 60.520103][ T8177] netdevsim netdevsim2 netdevsim0: renamed from eth0 [ 60.597287][ T8177] netdevsim netdevsim2 netdevsim1: renamed from eth1 [ 60.638959][ T8173] 8021q: adding VLAN 0 to HW filter on device bond0 [ 60.648647][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan1: link becomes ready [ 60.656179][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): vxcan0: link becomes ready [ 60.665807][ T8184] bridge0: port 1(bridge_slave_0) entered blocking state [ 60.672885][ T8184] bridge0: port 1(bridge_slave_0) entered disabled state [ 60.687065][ T8184] device bridge_slave_0 entered promiscuous mode [ 60.698157][ T8184] bridge0: port 2(bridge_slave_1) entered blocking state [ 60.705661][ T8184] bridge0: port 2(bridge_slave_1) entered disabled state [ 60.719396][ T8184] device bridge_slave_1 entered promiscuous mode [ 60.730560][ T8177] netdevsim netdevsim2 netdevsim2: renamed from eth2 [ 60.774905][ T8177] netdevsim netdevsim2 netdevsim3: renamed from eth3 [ 60.819883][ T8182] netdevsim netdevsim4 netdevsim0: renamed from eth0 [ 60.864979][ T8182] netdevsim netdevsim4 netdevsim1: renamed from eth1 [ 166.073187][ C1] rcu: INFO: rcu_preempt self-detected stall on CPU [ 166.079936][ C1] rcu: 1-...!: (1 GPs behind) idle=012/1/0x4000000000000002 softirq=10249/10252 fqs=33 [ 166.089871][ C1] (t=10501 jiffies g=6345 q=181) [ 166.094886][ C1] rcu: rcu_preempt kthread starved for 10436 jiffies! g6345 f0x0 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0 [ 166.105974][ C1] rcu: RCU grace-period kthread stack dump: [ 166.111850][ C1] rcu_preempt R running task 29032 10 2 0x80004000 [ 166.119835][ C1] Call Trace: [ 166.123149][ C1] __schedule+0x9a0/0xcc0 [ 166.127486][ C1] schedule+0x181/0x210 [ 166.131652][ C1] schedule_timeout+0x14f/0x240 [ 166.136502][ C1] ? run_local_timers+0x120/0x120 [ 166.141968][ C1] rcu_gp_kthread+0xed8/0x1770 [ 166.146739][ C1] kthread+0x332/0x350 [ 166.150798][ C1] ? rcu_report_qs_rsp+0x140/0x140 [ 166.155901][ C1] ? kthread_blkcg+0xe0/0xe0 [ 166.160485][ C1] ret_from_fork+0x24/0x30 [ 166.164907][ C1] NMI backtrace for cpu 1 [ 166.169229][ C1] CPU: 1 PID: 367 Comm: kworker/u4:5 Not tainted 5.4.0-syzkaller #0 [ 166.177191][ C1] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 166.187241][ C1] Workqueue: events_unbound fsnotify_connector_destroy_workfn [ 166.194694][ C1] Call Trace: [ 166.197973][ C1] [ 166.200823][ C1] dump_stack+0x1fb/0x318 [ 166.205159][ C1] nmi_cpu_backtrace+0xaf/0x1a0 [ 166.209993][ C1] ? nmi_trigger_cpumask_backtrace+0x16d/0x290 [ 166.216142][ C1] ? arch_trigger_cpumask_backtrace+0x20/0x20 [ 166.222196][ C1] nmi_trigger_cpumask_backtrace+0x174/0x290 [ 166.228171][ C1] arch_trigger_cpumask_backtrace+0x10/0x20 [ 166.234072][ C1] rcu_dump_cpu_stacks+0x15a/0x220 [ 166.239638][ C1] rcu_sched_clock_irq+0xe25/0x1ad0 [ 166.244841][ C1] ? trace_hardirqs_off+0x74/0x80 [ 166.249856][ C1] update_process_times+0x12d/0x180 [ 166.255045][ C1] tick_sched_timer+0x263/0x420 [ 166.259883][ C1] ? tick_setup_sched_timer+0x3d0/0x3d0 [ 166.265419][ C1] __hrtimer_run_queues+0x403/0x840 [ 166.270619][ C1] hrtimer_interrupt+0x38c/0xda0 [ 166.275560][ C1] ? debug_smp_processor_id+0x9/0x20 [ 166.280871][ C1] smp_apic_timer_interrupt+0x109/0x280 [ 166.286404][ C1] apic_timer_interrupt+0xf/0x20 [ 166.291470][ C1] [ 166.294413][ C1] RIP: 0010:free_thread_stack+0x177/0x590 [ 166.300124][ C1] Code: 80 3c 28 00 74 08 48 89 df e8 25 a4 69 00 48 8b 3b be fc ff ff ff e8 28 04 00 00 43 80 3c 2e 00 74 08 4c 89 e7 e8 09 a4 69 00 <49> 8b 1c 24 48 83 c3 08 48 89 d8 48 c1 e8 03 42 80 3c 28 00 74 08 [ 166.319717][ C1] RSP: 0018:ffffc90001cf7908 EFLAGS: 00000246 ORIG_RAX: ffffffffffffff13 [ 166.328118][ C1] RAX: ffffffff81487433 RBX: ffff888092777008 RCX: ffff8880a880a500 [ 166.336075][ C1] RDX: 0000000000000000 RSI: 00000000fffffffc RDI: ffffea0002a373c0 [ 166.344031][ C1] RBP: ffffc90001cf7940 R08: dffffc0000000000 R09: fffffbfff120248a [ 166.351986][ C1] R10: fffffbfff120248a R11: 0000000000000000 R12: ffff8880927770a0 [ 166.359942][ C1] R13: dffffc0000000000 R14: 1ffff110124eee14 R15: ffff8880a058f468 [ 166.367927][ C1] ? mod_memcg_page_state+0x123/0x190 [ 166.373290][ C1] ? free_thread_stack+0x168/0x590 [ 166.378390][ C1] put_task_stack+0xa3/0x130 [ 166.382966][ C1] finish_task_switch+0x3f1/0x550 [ 166.387984][ C1] __schedule+0x9a8/0xcc0 [ 166.392312][ C1] ? ___preempt_schedule+0x16/0x18 [ 166.397409][ C1] preempt_schedule+0xdb/0x120 [ 166.402160][ C1] ___preempt_schedule+0x16/0x18 [ 166.407085][ C1] _raw_spin_unlock_irqrestore+0xcc/0xe0 [ 166.412701][ C1] __call_srcu+0x7ab/0xb00 [ 166.417114][ C1] __synchronize_srcu+0x1cf/0x260 [ 166.422120][ C1] ? rcu_read_lock_any_held+0x1a0/0x1a0 [ 166.427678][ C1] synchronize_srcu+0x2cb/0x2f0 [ 166.432518][ C1] fsnotify_connector_destroy_workfn+0x44/0xb0 [ 166.438670][ C1] process_one_work+0x7ef/0x10d0 [ 166.443610][ C1] worker_thread+0xc01/0x1630 [ 166.448295][ C1] kthread+0x332/0x350 [ 166.452345][ C1] ? rcu_lock_release+0x30/0x30 [ 166.457203][ C1] ? kthread_blkcg+0xe0/0xe0 [ 166.461790][ C1] ret_from_fork+0x24/0x30