[info] Using makefile-style concurrent boot in runlevel 2. [ 56.021291][ T26] audit: type=1800 audit(1568441130.831:21): pid=9202 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="bootlogs" dev="sda1" ino=2419 res=0 [ 56.047123][ T26] audit: type=1800 audit(1568441130.831:22): pid=9202 uid=0 auid=4294967295 ses=4294967295 subj=_ op=collect_data cause=failed(directio) comm="startpar" name="motd" dev="sda1" ino=2447 res=0 [....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [....] 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.167' (ECDSA) to the list of known hosts. syzkaller login: [ 224.769562][ T9354] IPVS: ftp: loaded support on port[0] = 21 [ 224.804844][ T9354] chnl_net:caif_netlink_parms(): no params data found [ 224.825777][ T9354] bridge0: port 1(bridge_slave_0) entered blocking state [ 224.832949][ T9354] bridge0: port 1(bridge_slave_0) entered disabled state [ 224.841498][ T9354] device bridge_slave_0 entered promiscuous mode [ 224.848889][ T9354] bridge0: port 2(bridge_slave_1) entered blocking state [ 224.856451][ T9354] bridge0: port 2(bridge_slave_1) entered disabled state [ 224.864502][ T9354] device bridge_slave_1 entered promiscuous mode [ 224.877923][ T9354] bond0: (slave bond_slave_0): Enslaving as an active interface with an up link [ 224.888552][ T9354] bond0: (slave bond_slave_1): Enslaving as an active interface with an up link [ 224.903083][ T9354] team0: Port device team_slave_0 added [ 224.910002][ T9354] team0: Port device team_slave_1 added [ 224.966959][ T9354] device hsr_slave_0 entered promiscuous mode [ 225.035452][ T9354] device hsr_slave_1 entered promiscuous mode [ 225.120500][ T9354] bridge0: port 2(bridge_slave_1) entered blocking state [ 225.128227][ T9354] bridge0: port 2(bridge_slave_1) entered forwarding state [ 225.135755][ T9354] bridge0: port 1(bridge_slave_0) entered blocking state [ 225.142863][ T9354] bridge0: port 1(bridge_slave_0) entered forwarding state [ 225.164150][ T9354] 8021q: adding VLAN 0 to HW filter on device bond0 [ 225.173403][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 225.192695][ T5] bridge0: port 1(bridge_slave_0) entered disabled state [ 225.200515][ T5] bridge0: port 2(bridge_slave_1) entered disabled state [ 225.208517][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 225.218084][ T9354] 8021q: adding VLAN 0 to HW filter on device team0 [ 225.227384][ T3515] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 225.235732][ T3515] bridge0: port 1(bridge_slave_0) entered blocking state [ 225.242756][ T3515] bridge0: port 1(bridge_slave_0) entered forwarding state [ 225.260133][ T9354] hsr0: Slave A (hsr_slave_0) is not up; please bring it up to get a fully working HSR network [ 225.271465][ T9354] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 225.283150][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 225.291811][ T5] bridge0: port 2(bridge_slave_1) entered blocking state [ 225.299426][ T5] bridge0: port 2(bridge_slave_1) entered forwarding state [ 225.307700][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 225.316205][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready executing program executing program executing program executing program executing program executing program executing program [ 225.324374][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 225.332616][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready [ 225.340902][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 225.348518][ T5] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 225.361997][ T9354] 8021q: adding VLAN 0 to HW filter on device batadv0 executing program executing program executing program [ 330.415161][ C1] rcu: INFO: rcu_preempt detected stalls on CPUs/tasks: [ 330.422143][ C1] (detected by 1, t=10502 jiffies, g=7585, q=246) [ 330.428628][ C1] rcu: All QSes seen, last rcu_preempt kthread activity 10503 (4294970158-4294959655), jiffies_till_next_fqs=1, root ->qsmask 0x0 [ 330.441965][ C1] syz-executor781 R running task 28792 9373 9354 0x0000000a [ 330.449858][ C1] Call Trace: [ 330.453128][ C1] [ 330.455982][ C1] sched_show_task+0x348/0x400 [ 330.460744][ C1] rcu_sched_clock_irq+0x1597/0x16d0 [ 330.466014][ C1] update_process_times+0x134/0x190 [ 330.471197][ C1] tick_sched_timer+0x263/0x420 [ 330.476063][ C1] ? tick_setup_sched_timer+0x2c0/0x2c0 [ 330.481605][ C1] __hrtimer_run_queues+0x403/0x850 [ 330.486885][ C1] hrtimer_interrupt+0x38c/0xda0 [ 330.491819][ C1] smp_apic_timer_interrupt+0x109/0x280 [ 330.497348][ C1] apic_timer_interrupt+0xf/0x20 [ 330.502261][ C1] [ 330.505187][ C1] RIP: 0010:native_queued_spin_lock_slowpath+0x92/0x9e0 [ 330.512220][ C1] Code: 84 c0 74 54 44 89 f9 80 e1 07 80 c1 03 38 c1 7c 47 4c 89 ff e8 4f f4 51 00 eb 3d 0f 1f 00 66 2e 0f 1f 84 00 00 00 00 00 f3 90 <4c> 89 ff be 04 00 00 00 e8 61 c5 51 00 42 0f b6 04 2b 84 c0 74 18 [ 330.531806][ C1] RSP: 0018:ffff88809312f4f0 EFLAGS: 00000202 ORIG_RAX: ffffffffffffff13 [ 330.540198][ C1] RAX: 0000000000000000 RBX: 1ffff110140d52f5 RCX: ffffffff815a940f [ 330.548156][ C1] RDX: 0000000000000000 RSI: 0000000000000004 RDI: ffff8880a06a97a8 [ 330.556111][ C1] RBP: ffff88809312f568 R08: dffffc0000000000 R09: ffffed10140d52f6 [ 330.564082][ C1] R10: ffffed10140d52f6 R11: 0000000000000000 R12: ffff8880a06a97b0 [ 330.572387][ C1] R13: dffffc0000000000 R14: 0000000000000001 R15: ffff8880a06a97a8 [ 330.580465][ C1] ? native_queued_spin_lock_slowpath+0x9f/0x9e0 [ 330.586789][ C1] ? trace_lock_acquire+0x159/0x1d0 [ 330.591979][ C1] do_raw_spin_lock+0x1d6/0x2d0 [ 330.596823][ C1] ? hhf_change+0x250/0x9b0 [ 330.601321][ C1] _raw_spin_lock_bh+0x40/0x50 [ 330.606431][ C1] hhf_change+0x250/0x9b0 [ 330.610784][ C1] ? nla_strcmp+0xd2/0x120 [ 330.615183][ C1] ? hhf_destroy+0x410/0x410 [ 330.619755][ C1] tc_modify_qdisc+0x184d/0x1ea0 [ 330.624685][ C1] ? trace_lock_release+0x135/0x1a0 [ 330.629871][ C1] ? rcu_lock_release+0x30/0x30 [ 330.634704][ C1] rtnetlink_rcv_msg+0x889/0xd40 [ 330.639625][ C1] ? rcu_lock_release+0xd/0x30 [ 330.644378][ C1] ? rcu_lock_release+0xd/0x30 [ 330.649130][ C1] ? __local_bh_enable_ip+0x13a/0x240 [ 330.654495][ C1] ? check_preemption_disabled+0x47/0x2a0 [ 330.660196][ C1] ? trace_irq_enable_rcuidle+0x23/0x1e0 [ 330.665810][ C1] ? local_bh_enable+0x9/0x30 [ 330.670468][ C1] ? trace_hardirqs_on+0x74/0x80 [ 330.675389][ C1] ? __local_bh_enable_ip+0x13a/0x240 [ 330.681174][ C1] ? local_bh_enable+0x1f/0x30 [ 330.685920][ C1] ? rcu_lock_release+0x9/0x30 [ 330.690772][ C1] ? trace_lock_release+0x135/0x1a0 [ 330.695954][ C1] ? rcu_lock_release+0x9/0x30 [ 330.700903][ C1] netlink_rcv_skb+0x19e/0x3d0 [ 330.705658][ C1] ? rtnetlink_bind+0x80/0x80 [ 330.710323][ C1] rtnetlink_rcv+0x1c/0x20 [ 330.714807][ C1] netlink_unicast+0x787/0x900 [ 330.719557][ C1] netlink_sendmsg+0x993/0xc50 [ 330.724308][ C1] ? netlink_getsockopt+0x9f0/0x9f0 [ 330.729488][ C1] ___sys_sendmsg+0x60d/0x910 [ 330.734152][ C1] ? sock_do_ioctl+0x212/0x260 [ 330.738905][ C1] ? sock_ioctl+0x461/0x680 [ 330.743588][ C1] ? check_preemption_disabled+0xb7/0x2a0 [ 330.749302][ C1] ? sock_poll+0x310/0x310 [ 330.754226][ C1] ? __fdget+0x156/0x200 [ 330.758450][ C1] __x64_sys_sendmsg+0x17c/0x200 [ 330.764167][ C1] do_syscall_64+0xfe/0x140 [ 330.768658][ C1] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 330.774546][ C1] RIP: 0033:0x442399 [ 330.778514][ C1] Code: e8 9c 07 03 00 48 83 c4 18 c3 0f 1f 80 00 00 00 00 48 89 f8 48 89 f7 48 89 d6 48 89 ca 4d 89 c2 4d 89 c8 4c 8b 4c 24 08 0f 05 <48> 3d 01 f0 ff ff 0f 83 3b 0a fc ff c3 66 2e 0f 1f 84 00 00 00 00 [ 330.798367][ C1] RSP: 002b:00007ffe98336468 EFLAGS: 00000246 ORIG_RAX: 000000000000002e [ 330.806759][ C1] RAX: ffffffffffffffda RBX: 0000000000000003 RCX: 0000000000442399 [ 330.814713][ C1] RDX: 0000000000000000 RSI: 0000000020000240 RDI: 0000000000000003 [ 330.822666][ C1] RBP: 0000000000037053 R08: 0000000000000000 R09: 0000000000000000 [ 330.830679][ C1] R10: 0000000000000000 R11: 0000000000000246 R12: 0000000000000000 [ 330.838809][ C1] R13: 00000000004032f0 R14: 0000000000000000 R15: 0000000000000000 [ 330.846795][ C1] rcu: rcu_preempt kthread starved for 10545 jiffies! g7585 f0x2 RCU_GP_WAIT_FQS(5) ->state=0x0 ->cpu=0 [ 330.857873][ C1] rcu: RCU grace-period kthread stack dump: [ 330.863744][ C1] rcu_preempt R running task 29080 10 2 0x80004000 [ 330.871796][ C1] Call Trace: [ 330.875072][ C1] __schedule+0x877/0xc50 [ 330.879388][ C1] schedule+0x131/0x1e0 [ 330.883527][ C1] schedule_timeout+0x14f/0x240 [ 330.888446][ C1] ? run_local_timers+0x120/0x120 [ 330.893456][ C1] rcu_gp_kthread+0xef8/0x1790 [ 330.898985][ C1] kthread+0x332/0x350 [ 330.903124][ C1] ? rcu_report_qs_rsp+0x150/0x150 [ 330.908218][ C1] ? kthread_blkcg+0xe0/0xe0 [ 330.912965][ C1] ret_from_fork+0x24/0x30