[....] Starting enhanced syslogd: rsyslogd[?25l[?1c7[ ok 8[?25h[?0c. [ 40.109473][ T27] audit: type=1800 audit(1555940911.426:25): pid=7782 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="cron" dev="sda1" ino=2414 res=0 [ 40.147033][ T27] audit: type=1800 audit(1555940911.426:26): pid=7782 uid=0 auid=4294967295 ses=4294967295 subj==unconfined op=collect_data cause=failed(directio) comm="startpar" name="mcstrans" dev="sda1" ino=2457 res=0 [ 40.174337][ T27] audit: type=1800 audit(1555940911.426:27): pid=7782 uid=0 auid=4294967295 ses=4294967295 subj==unconfined 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.13' (ECDSA) to the list of known hosts. syzkaller login: [ 713.031633][ T7934] IPVS: ftp: loaded support on port[0] = 21 [ 713.093951][ T7934] chnl_net:caif_netlink_parms(): no params data found [ 713.128053][ T7934] bridge0: port 1(bridge_slave_0) entered blocking state [ 713.135815][ T7934] bridge0: port 1(bridge_slave_0) entered disabled state [ 713.144049][ T7934] device bridge_slave_0 entered promiscuous mode [ 713.152543][ T7934] bridge0: port 2(bridge_slave_1) entered blocking state [ 713.160191][ T7934] bridge0: port 2(bridge_slave_1) entered disabled state [ 713.167995][ T7934] device bridge_slave_1 entered promiscuous mode [ 713.183970][ T7934] bond0: Enslaving bond_slave_0 as an active interface with an up link [ 713.194207][ T7934] bond0: Enslaving bond_slave_1 as an active interface with an up link [ 713.211772][ T7934] team0: Port device team_slave_0 added [ 713.219096][ T7934] team0: Port device team_slave_1 added [ 713.298332][ T7934] device hsr_slave_0 entered promiscuous mode [ 713.367061][ T7934] device hsr_slave_1 entered promiscuous mode [ 713.444284][ T7934] bridge0: port 2(bridge_slave_1) entered blocking state [ 713.451632][ T7934] bridge0: port 2(bridge_slave_1) entered forwarding state [ 713.459493][ T7934] bridge0: port 1(bridge_slave_0) entered blocking state [ 713.467254][ T7934] bridge0: port 1(bridge_slave_0) entered forwarding state [ 713.500182][ T7934] 8021q: adding VLAN 0 to HW filter on device bond0 [ 713.512676][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): veth0: link becomes ready [ 713.533600][ T12] bridge0: port 1(bridge_slave_0) entered disabled state [ 713.542045][ T12] bridge0: port 2(bridge_slave_1) entered disabled state [ 713.551059][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): bond0: link becomes ready [ 713.563256][ T7934] 8021q: adding VLAN 0 to HW filter on device team0 [ 713.573945][ T3485] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_0: link becomes ready [ 713.582426][ T3485] bridge0: port 1(bridge_slave_0) entered blocking state [ 713.589534][ T3485] bridge0: port 1(bridge_slave_0) entered forwarding state [ 713.608764][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): bridge_slave_1: link becomes ready [ 713.617515][ T12] bridge0: port 2(bridge_slave_1) entered blocking state [ 713.624550][ T12] bridge0: port 2(bridge_slave_1) entered forwarding state [ 713.633094][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_0: link becomes ready [ 713.641659][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): team_slave_1: link becomes ready [ 713.650563][ T12] IPv6: ADDRCONF(NETDEV_CHANGE): team0: link becomes ready [ 713.661443][ T7936] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_0: link becomes ready [ 713.672992][ T7934] hsr0: Slave B (hsr_slave_1) is not up; please bring it up to get a fully working HSR network [ 713.684617][ T7934] IPv6: ADDRCONF(NETDEV_CHANGE): hsr0: link becomes ready [ 713.692602][ T7936] IPv6: ADDRCONF(NETDEV_CHANGE): hsr_slave_1: link becomes ready executing program [ 713.710300][ T7934] 8021q: adding VLAN 0 to HW filter on device batadv0 [ 876.166575][ T1043] INFO: task syz-executor483:7934 blocked for more than 143 seconds. [ 876.175060][ T1043] Not tainted 5.1.0-rc5-next-20190418 #28 [ 876.182602][ T1043] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. [ 876.191523][ T1043] syz-executor483 D23720 7934 7933 0x00000000 [ 876.199117][ T1043] Call Trace: [ 876.202538][ T1043] __schedule+0x7d1/0x15c0 [ 876.207340][ T1043] ? __sched_text_start+0x8/0x8 [ 876.212210][ T1043] ? _raw_spin_unlock_irq+0x28/0x90 [ 876.218688][ T1043] ? _raw_spin_unlock_irq+0x28/0x90 [ 876.224040][ T1043] ? lockdep_hardirqs_on+0x418/0x5d0 [ 876.229605][ T1043] schedule+0xa8/0x260 [ 876.233712][ T1043] rwsem_down_read_failed+0x213/0x460 [ 876.241258][ T1043] ? rwsem_down_write_failed+0xc60/0xc60 [ 876.247211][ T1043] ? __do_page_fault+0x9e9/0xda0 [ 876.252183][ T1043] down_read+0xa5/0x1a0 [ 876.256577][ T1043] __do_page_fault+0x9e9/0xda0 [ 876.261466][ T1043] ? trace_hardirqs_off_caller+0x65/0x220 [ 876.268528][ T1043] do_page_fault+0x71/0x581 [ 876.273066][ T1043] ? page_fault+0x8/0x30 [ 876.277535][ T1043] page_fault+0x1e/0x30 [ 876.281731][ T1043] RIP: 0033:0x4aeb50 [ 876.285652][ T1043] Code: Bad RIP value. [ 876.291004][ T1043] RSP: 002b:00007ffd892b5808 EFLAGS: 00010206 [ 876.297415][ T1043] RAX: 00000000004aeb50 RBX: 0000000000000001 RCX: 00000000006e47b0 [ 876.305420][ T1043] RDX: 0000000000409e20 RSI: 0000000000000001 RDI: 00000000004d0470 [ 876.314673][ T1043] RBP: 00007ffd892b5810 R08: 00007ffd892b5d09 R09: 00007ffd892b5d09 [ 876.322887][ T1043] R10: 00007ffd892b5890 R11: 0000000000000000 R12: 0000000000000001 [ 876.332354][ T1043] R13: 00000000006e47a0 R14: 000000000000002d R15: 0000000000000006 [ 876.340624][ T1043] [ 876.340624][ T1043] Showing all locks held in the system: [ 876.349632][ T1043] 1 lock held by khungtaskd/1043: [ 876.354760][ T1043] #0: 0000000094fd50cd (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x27e [ 876.364378][ T1043] 3 locks held by rs:main Q:Reg/7818: [ 876.372056][ T1043] #0: 000000009de82e2c (&rq->lock){-.-.}, at: __schedule+0x1f5/0x15c0 [ 876.380593][ T1043] #1: 0000000094fd50cd (rcu_read_lock){....}, at: vfs_write+0x429/0x580 [ 876.390353][ T1043] #2: 000000009e84d141 (&sb->s_type->i_mutex_key#10){+.+.}, at: ext4_file_write_iter+0x257/0x11c0 [ 876.401377][ T1043] 1 lock held by rsyslogd/7820: [ 876.406238][ T1043] #0: 00000000e9d702ac (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 [ 876.417375][ T1043] 2 locks held by getty/7911: [ 876.422062][ T1043] #0: 000000007b03ef87 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 [ 876.432298][ T1043] #1: 000000008a1b8e3f (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 [ 876.442208][ T1043] 2 locks held by getty/7912: [ 876.448128][ T1043] #0: 000000001b88eeb0 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 [ 876.457340][ T1043] #1: 00000000bf3e0004 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 [ 876.468179][ T1043] 2 locks held by getty/7913: [ 876.472874][ T1043] #0: 00000000b713aa93 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 [ 876.482109][ T1043] #1: 00000000e920f7f2 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 [ 876.493371][ T1043] 2 locks held by getty/7914: [ 876.499088][ T1043] #0: 00000000338a9170 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 [ 876.509330][ T1043] #1: 00000000765055aa (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 [ 876.519169][ T1043] 2 locks held by getty/7915: [ 876.523884][ T1043] #0: 00000000e3b3e84c (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 [ 876.534126][ T1043] #1: 00000000f0c96d15 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 [ 876.544086][ T1043] 2 locks held by getty/7916: [ 876.550085][ T1043] #0: 00000000fa9a42ff (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 [ 876.559393][ T1043] #1: 0000000003f8d2e2 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 [ 876.570316][ T1043] 2 locks held by getty/7917: [ 876.575127][ T1043] #0: 000000002f77ac70 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 [ 876.584395][ T1043] #1: 000000007de33b6e (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 [ 876.595264][ T1043] 1 lock held by syz-executor483/7934: [ 876.601014][ T1043] #0: 00000000d53d7946 (&mm->mmap_sem){++++}, at: __do_page_fault+0x9e9/0xda0 [ 876.611223][ T1043] 1 lock held by syz-executor483/7943: [ 876.616878][ T1043] [ 876.619214][ T1043] ============================================= [ 876.619214][ T1043] [ 876.629751][ T1043] NMI backtrace for cpu 1 [ 876.634132][ T1043] CPU: 1 PID: 1043 Comm: khungtaskd Not tainted 5.1.0-rc5-next-20190418 #28 [ 876.642807][ T1043] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 876.652878][ T1043] Call Trace: [ 876.656229][ T1043] dump_stack+0x172/0x1f0 [ 876.660584][ T1043] nmi_cpu_backtrace.cold+0x63/0xa4 [ 876.665889][ T1043] ? lapic_can_unplug_cpu.cold+0x38/0x38 [ 876.671542][ T1043] nmi_trigger_cpumask_backtrace+0x1be/0x236 [ 876.677544][ T1043] arch_trigger_cpumask_backtrace+0x14/0x20 [ 876.683606][ T1043] watchdog+0x9b7/0xec0 [ 876.687829][ T1043] kthread+0x357/0x430 [ 876.691924][ T1043] ? reset_hung_task_detector+0x30/0x30 [ 876.697484][ T1043] ? kthread_cancel_delayed_work_sync+0x20/0x20 [ 876.703741][ T1043] ret_from_fork+0x3a/0x50 [ 876.708294][ T1043] Sending NMI from CPU 1 to CPUs 0: [ 876.714313][ C0] NMI backtrace for cpu 0 [ 876.714328][ C0] CPU: 0 PID: 7943 Comm: syz-executor483 Not tainted 5.1.0-rc5-next-20190418 #28 [ 876.714335][ C0] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 876.714339][ C0] RIP: 0010:debug_lockdep_rcu_enabled.part.0+0x37/0x60 [ 876.714351][ C0] Code: e5 53 65 48 8b 1c 25 c0 fd 01 00 48 8d bb 7c 08 00 00 48 89 fa 48 c1 ea 03 0f b6 14 02 48 89 f8 83 e0 07 83 c0 03 38 d0 7c 04 <84> d2 75 10 8b 93 7c 08 00 00 31 c0 5b 5d 85 d2 0f 94 c0 c3 e8 60 [ 876.714356][ C0] RSP: 0018:ffff8880940778e8 EFLAGS: 00000002 [ 876.714364][ C0] RAX: 0000000000000007 RBX: ffff88808d174480 RCX: 1ffffffff12c0076 [ 876.714370][ C0] RDX: 0000000000000000 RSI: 0000000000000000 RDI: ffff88808d174cfc [ 876.714375][ C0] RBP: ffff8880940778f0 R08: 0000000000000000 R09: ffffed1010d8076e [ 876.714380][ C0] R10: ffffed1010d8076d R11: ffff888086c03b6b R12: ffff8880a65f9090 [ 876.714386][ C0] R13: ffffffff81882cfa R14: ffff88808d174480 R15: ffff8880940779a0 [ 876.714392][ C0] FS: 00007f08a99d5700(0000) GS:ffff8880ae800000(0000) knlGS:0000000000000000 [ 876.714396][ C0] CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 [ 876.714402][ C0] CR2: ffffffffff600400 CR3: 0000000091e1c000 CR4: 00000000001406f0 [ 876.714405][ C0] Call Trace: [ 876.714409][ C0] debug_lockdep_rcu_enabled+0x71/0xa0 [ 876.714413][ C0] lock_release+0x5d6/0xa00 [ 876.714416][ C0] ? perf_mmap+0x749/0x17f0 [ 876.714420][ C0] ? lock_downgrade+0x880/0x880 [ 876.714424][ C0] ? mutex_trylock+0x1e0/0x1e0 [ 876.714428][ C0] __mutex_unlock_slowpath+0x8e/0x6b0 [ 876.714432][ C0] ? wait_for_completion+0x440/0x440 [ 876.714435][ C0] ? perf_mmap+0x815/0x17f0 [ 876.714439][ C0] mutex_unlock+0xd/0x10 [ 876.714442][ C0] perf_mmap+0x73a/0x17f0 [ 876.714446][ C0] ? perf_release+0x50/0x50 [ 876.714449][ C0] ? memset+0x32/0x40 [ 876.714453][ C0] mmap_region+0xc3a/0x1750 [ 876.714457][ C0] ? __x64_sys_brk+0x760/0x760 [ 876.714461][ C0] ? __sanitizer_cov_trace_const_cmp8+0x18/0x20 [ 876.714465][ C0] ? get_unmapped_area+0x295/0x3b0 [ 876.714468][ C0] do_mmap+0x924/0x1090 [ 876.714472][ C0] vm_mmap_pgoff+0x1c5/0x230 [ 876.714476][ C0] ? vma_is_stack_for_current+0xd0/0xd0 [ 876.714480][ C0] ? ksys_dup3+0x3e0/0x3e0 [ 876.714483][ C0] ksys_mmap_pgoff+0x4aa/0x630 [ 876.714488][ C0] ? find_mergeable_anon_vma+0x2e0/0x2e0 [ 876.714492][ C0] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 876.714496][ C0] ? trace_hardirqs_on_thunk+0x1a/0x1c [ 876.714499][ C0] ? do_syscall_64+0x26/0x670 [ 876.714504][ C0] ? entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 876.714508][ C0] __x64_sys_mmap+0xe9/0x1b0 [ 876.714512][ C0] do_syscall_64+0x103/0x670 [ 876.714516][ C0] entry_SYSCALL_64_after_hwframe+0x49/0xbe [ 876.714519][ C0] RIP: 0033:0x448c89 [ 876.714531][ C0] Code: e8 7c 1a 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 7b 0c fc ff c3 66 2e 0f 1f 84 00 00 00 00 [ 876.714535][ C0] RSP: 002b:00007f08a99d4cd8 EFLAGS: 00000246 ORIG_RAX: 0000000000000009 [ 876.714545][ C0] RAX: ffffffffffffffda RBX: 00000000006dfc58 RCX: 0000000000448c89 [ 876.714551][ C0] RDX: 0000000000000000 RSI: 0000000000003000 RDI: 0000000020ffd000 [ 876.714556][ C0] RBP: 00000000006dfc50 R08: 0000000000000003 R09: 0000000000000000 [ 876.714562][ C0] R10: 0000000000001011 R11: 0000000000000246 R12: 00000000006dfc5c [ 876.714567][ C0] R13: 00007ffd892b57ef R14: 00007f08a99d59c0 R15: 0000000000000005 [ 876.716648][ T1043] Kernel panic - not syncing: hung_task: blocked tasks [ 877.061469][ T1043] CPU: 1 PID: 1043 Comm: khungtaskd Not tainted 5.1.0-rc5-next-20190418 #28 [ 877.070154][ T1043] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 877.080223][ T1043] Call Trace: [ 877.083532][ T1043] dump_stack+0x172/0x1f0 [ 877.087974][ T1043] panic+0x2cb/0x72b [ 877.091900][ T1043] ? __warn_printk+0xf3/0xf3 [ 877.096510][ T1043] ? lapic_can_unplug_cpu.cold+0x38/0x38 [ 877.102172][ T1043] ? ___preempt_schedule+0x16/0x18 [ 877.107313][ T1043] ? nmi_trigger_cpumask_backtrace+0x19e/0x236 [ 877.113495][ T1043] ? nmi_trigger_cpumask_backtrace+0x1fa/0x236 [ 877.119667][ T1043] ? nmi_trigger_cpumask_backtrace+0x204/0x236 [ 877.125858][ T1043] ? nmi_trigger_cpumask_backtrace+0x19e/0x236 [ 877.132042][ T1043] watchdog+0x9c8/0xec0 [ 877.136225][ T1043] kthread+0x357/0x430 [ 877.140356][ T1043] ? reset_hung_task_detector+0x30/0x30 [ 877.145946][ T1043] ? kthread_cancel_delayed_work_sync+0x20/0x20 [ 877.152223][ T1043] ret_from_fork+0x3a/0x50 [ 877.157656][ T1043] Kernel Offset: disabled [ 877.162005][ T1043] Rebooting in 86400 seconds..