INIT: Entering runlevel: 2 [info] Using makefile-style concurrent boot in runlevel 2. [....] 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 'ci-upstream-next-kasan-gce-2,10.128.15.206' (ECDSA) to the list of known hosts. 2017/08/27 12:18:01 parsed 1 programs 2017/08/27 12:18:01 executed programs: 0 syzkaller login: [ 47.410946] [ 47.412629] ====================================================== [ 47.418914] WARNING: possible circular locking dependency detected [ 47.425199] 4.13.0-rc6-next-20170825+ #9 Not tainted [ 47.430265] ------------------------------------------------------ [ 47.436547] syz-executor0/3357 is trying to acquire lock: [ 47.442046] (event_mutex){+.+.}, at: [] perf_trace_destroy+0x28/0x100 [ 47.450252] [ 47.450252] but task is already holding lock: [ 47.456188] (&mm->mmap_sem){++++}, at: [] vm_mmap_pgoff+0x198/0x280 [ 47.464222] [ 47.464222] which lock already depends on the new lock. [ 47.464222] [ 47.472500] [ 47.472500] the existing dependency chain (in reverse order) is: [ 47.480084] [ 47.480084] -> #7 (&mm->mmap_sem){++++}: [ 47.485599] __lock_acquire+0x3286/0x4620 [ 47.490242] lock_acquire+0x1d5/0x580 [ 47.494531] __might_fault+0x13a/0x1d0 [ 47.498907] _copy_to_user+0x2c/0xc0 [ 47.503106] filldir+0x1a7/0x320 [ 47.506960] dcache_readdir+0x12d/0x5e0 [ 47.511434] iterate_dir+0x4b2/0x5d0 [ 47.515631] SyS_getdents+0x225/0x450 [ 47.519931] entry_SYSCALL_64_fastpath+0x1f/0xbe [ 47.525171] [ 47.525171] -> #6 (&sb->s_type->i_mutex_key#5){++++}: [ 47.531808] down_write+0x87/0x120 [ 47.535835] handle_create+0x30c/0x760 [ 47.540210] devtmpfsd+0x3eb/0x520 [ 47.544324] kthread+0x39c/0x470 [ 47.548176] ret_from_fork+0x2a/0x40 [ 47.552372] [ 47.552372] -> #5 ((complete)&req.done){+.+.}: [ 47.558432] __lock_acquire+0x3286/0x4620 [ 47.563066] lock_acquire+0x1d5/0x580 [ 47.567354] wait_for_completion+0xc8/0x770 [ 47.572170] devtmpfs_create_node+0x32b/0x4a0 [ 47.577152] device_add+0x120f/0x1640 [ 47.581437] device_create_groups_vargs+0x1f3/0x250 [ 47.586942] device_create+0xda/0x110 [ 47.591234] msr_device_create+0x26/0x40 [ 47.595781] cpuhp_invoke_callback+0x256/0x14d0 [ 47.600936] cpuhp_thread_fun+0x265/0x520 [ 47.605570] smpboot_thread_fn+0x489/0x850 [ 47.610288] kthread+0x39c/0x470 [ 47.614140] ret_from_fork+0x2a/0x40 [ 47.618340] [ 47.618340] -> #4 (cpuhp_state){+.+.}: [ 47.623684] __lock_acquire+0x3286/0x4620 [ 47.628320] lock_acquire+0x1d5/0x580 [ 47.632605] cpuhp_issue_call+0x1a2/0x3e0 [ 47.637239] __cpuhp_setup_state_cpuslocked+0x2e7/0x610 [ 47.643089] __cpuhp_setup_state+0xb0/0x140 [ 47.647900] page_writeback_init+0x4d/0x71 [ 47.652619] pagecache_init+0x48/0x4f [ 47.656914] start_kernel+0x71a/0x7ad [ 47.661200] x86_64_start_reservations+0x2a/0x2c [ 47.666440] x86_64_start_kernel+0x13c/0x149 [ 47.671337] verify_cpu+0x0/0xfb [ 47.675186] [ 47.675186] -> #3 (cpuhp_state_mutex){+.+.}: [ 47.681045] __lock_acquire+0x3286/0x4620 [ 47.685694] lock_acquire+0x1d5/0x580 [ 47.689983] __mutex_lock+0x16f/0x1870 [ 47.694356] mutex_lock_nested+0x16/0x20 [ 47.698904] __cpuhp_setup_state_cpuslocked+0x5b/0x610 [ 47.704927] __cpuhp_setup_state+0xb0/0x140 [ 47.709747] kvm_guest_init+0x1f3/0x20f [ 47.714211] setup_arch+0x1899/0x1ab3 [ 47.718498] start_kernel+0xa5/0x7ad [ 47.722708] x86_64_start_reservations+0x2a/0x2c [ 47.727949] x86_64_start_kernel+0x13c/0x149 [ 47.732845] verify_cpu+0x0/0xfb [ 47.736697] [ 47.736697] -> #2 (cpu_hotplug_lock.rw_sem){++++}: [ 47.743077] __lock_acquire+0x3286/0x4620 [ 47.747720] lock_acquire+0x1d5/0x580 [ 47.752009] cpus_read_lock+0x42/0x90 [ 47.756296] static_key_slow_inc+0x9d/0x3c0 [ 47.761105] tracepoint_probe_register_prio+0x80d/0x9a0 [ 47.766952] tracepoint_probe_register+0x2a/0x40 [ 47.772196] trace_event_reg+0x167/0x320 [ 47.776742] perf_trace_init+0x504/0xab0 [ 47.781288] perf_tp_event_init+0x7d/0xf0 [ 47.785924] perf_try_init_event+0xc9/0x1f0 [ 47.790729] perf_event_alloc+0x1c5b/0x2a00 [ 47.795536] SYSC_perf_event_open+0x7f3/0x2d90 [ 47.800601] SyS_perf_event_open+0x39/0x50 [ 47.805330] entry_SYSCALL_64_fastpath+0x1f/0xbe [ 47.810568] [ 47.810568] -> #1 (tracepoints_mutex){+.+.}: [ 47.816425] __lock_acquire+0x3286/0x4620 [ 47.821068] lock_acquire+0x1d5/0x580 [ 47.825353] __mutex_lock+0x16f/0x1870 [ 47.829724] mutex_lock_nested+0x16/0x20 [ 47.834273] tracepoint_probe_register_prio+0xa0/0x9a0 [ 47.840034] tracepoint_probe_register+0x2a/0x40 [ 47.845275] trace_event_reg+0x167/0x320 [ 47.849821] perf_trace_init+0x504/0xab0 [ 47.854365] perf_tp_event_init+0x7d/0xf0 [ 47.859007] perf_try_init_event+0xc9/0x1f0 [ 47.863812] perf_event_alloc+0x1c5b/0x2a00 [ 47.868628] SYSC_perf_event_open+0x7f3/0x2d90 [ 47.873697] SyS_perf_event_open+0x39/0x50 [ 47.878440] entry_SYSCALL_64_fastpath+0x1f/0xbe [ 47.883680] [ 47.883680] -> #0 (event_mutex){+.+.}: [ 47.889019] check_prev_add+0x865/0x1520 [ 47.893566] __lock_acquire+0x3286/0x4620 [ 47.898208] lock_acquire+0x1d5/0x580 [ 47.902496] __mutex_lock+0x16f/0x1870 [ 47.906878] mutex_lock_nested+0x16/0x20 [ 47.911425] perf_trace_destroy+0x28/0x100 [ 47.916148] tp_perf_event_destroy+0x15/0x20 [ 47.921043] _free_event+0x401/0x1130 [ 47.925346] put_event+0x24/0x30 [ 47.929218] perf_mmap_close+0x60d/0xf90 [ 47.933784] remove_vma+0xb4/0x1b0 [ 47.937817] do_munmap+0x82a/0xdf0 [ 47.941847] mmap_region+0x59e/0x15a0 [ 47.946157] do_mmap+0x6a1/0xd50 [ 47.950014] vm_mmap_pgoff+0x1de/0x280 [ 47.954391] SyS_mmap_pgoff+0x23b/0x5f0 [ 47.958851] SyS_mmap+0x16/0x20 [ 47.962623] entry_SYSCALL_64_fastpath+0x1f/0xbe [ 47.967865] [ 47.967865] other info that might help us debug this: [ 47.967865] [ 47.975984] Chain exists of: [ 47.975984] event_mutex --> &sb->s_type->i_mutex_key#5 --> &mm->mmap_sem [ 47.975984] [ 47.987323] Possible unsafe locking scenario: [ 47.987323] [ 47.993346] CPU0 CPU1 [ 47.997977] ---- ---- [ 48.002608] lock(&mm->mmap_sem); [ 48.006113] lock(&sb->s_type->i_mutex_key#5); [ 48.013264] lock(&mm->mmap_sem); [ 48.019284] lock(event_mutex); [ 48.022613] [ 48.022613] *** DEADLOCK *** [ 48.022613] [ 48.028636] 1 lock held by syz-executor0/3357: [ 48.033181] #0: (&mm->mmap_sem){++++}, at: [] vm_mmap_pgoff+0x198/0x280 [ 48.041651] [ 48.041651] stack backtrace: [ 48.046116] CPU: 1 PID: 3357 Comm: syz-executor0 Not tainted 4.13.0-rc6-next-20170825+ #9 [ 48.054394] Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 [ 48.063712] Call Trace: [ 48.066276] dump_stack+0x194/0x257 [ 48.069873] ? arch_local_irq_restore+0x53/0x53 [ 48.074515] print_circular_bug+0x503/0x710 [ 48.078803] ? print_circular_bug_entry+0xb0/0xb0 [ 48.083610] ? __unwind_start+0x169/0x330 [ 48.087734] check_prev_add+0x865/0x1520 [ 48.091761] ? copy_trace+0x1d0/0x1d0 [ 48.095528] ? check_usage+0xb70/0xb70 [ 48.099397] ? hlock_class+0x140/0x140 [ 48.103251] ? copy_trace+0x1d0/0x1d0 [ 48.107015] __lock_acquire+0x3286/0x4620 [ 48.111127] ? __lock_acquire+0x3286/0x4620 [ 48.115413] ? copy_trace+0x1d0/0x1d0 [ 48.119195] ? debug_check_no_locks_freed+0x3d0/0x3d0 [ 48.124348] ? __unwind_start+0x169/0x330 [ 48.128459] ? unwind_get_return_address+0x61/0xa0 [ 48.133373] ? __read_once_size_nocheck.constprop.8+0x10/0x10 [ 48.139248] ? do_munmap+0x82a/0xdf0 [ 48.142933] ? __read_once_size_nocheck.constprop.8+0x10/0x10 [ 48.148785] ? lock_downgrade+0x990/0x990 [ 48.152896] ? mmap_region+0x59e/0x15a0 [ 48.156835] ? unwind_next_frame.part.6+0x1ae/0xc70 [ 48.161830] ? unwind_next_frame.part.6+0x1ae/0xc70 [ 48.166809] ? unwind_dump+0x4c0/0x4c0 [ 48.170658] ? unwind_dump+0x4c0/0x4c0 [ 48.174511] ? unwind_dump+0x4c0/0x4c0 [ 48.178365] ? __unwind_start+0x169/0x330 [ 48.182476] ? unwind_get_return_address+0x61/0xa0 [ 48.187372] ? __save_stack_trace+0x61/0xd0 [ 48.191658] ? check_noncircular+0x20/0x20 [ 48.195872] ? do_munmap+0x82a/0xdf0 [ 48.199552] ? save_stack_trace+0x16/0x20 [ 48.203662] ? __lock_acquire+0x20f4/0x4620 [ 48.207948] ? save_stack_trace+0x16/0x20 [ 48.212059] ? __lock_acquire+0x20f4/0x4620 [ 48.216347] lock_acquire+0x1d5/0x580 [ 48.220112] ? perf_trace_destroy+0x28/0x100 [ 48.224487] ? lock_release+0xd70/0xd70 [ 48.228429] ? check_same_owner+0x320/0x320 [ 48.232715] ? preempt_notifier_dec+0x20/0x20 [ 48.237179] ? rcu_note_context_switch+0x710/0x710 [ 48.242073] ? __might_sleep+0x95/0x190 [ 48.246012] ? perf_trace_destroy+0x28/0x100 [ 48.250401] __mutex_lock+0x16f/0x1870 [ 48.254252] ? perf_trace_destroy+0x28/0x100 [ 48.258626] ? __sched_text_start+0x8/0x8 [ 48.262737] ? perf_trace_destroy+0x28/0x100 [ 48.267133] ? mutex_lock_io_nested+0x1740/0x1740 [ 48.271947] ? lock_acquire+0x1d5/0x580 [ 48.275889] ? perf_mmap_close+0x5cb/0xf90 [ 48.280091] ? check_same_owner+0x320/0x320 [ 48.284378] ? check_noncircular+0x20/0x20 [ 48.288576] ? perf_mmap_close+0x33f/0xf90 [ 48.292780] ? check_noncircular+0x20/0x20 [ 48.297156] ? check_noncircular+0x20/0x20 [ 48.301355] ? print_usage_bug+0x480/0x480 [ 48.305555] ? __mutex_lock+0x16f/0x1870 [ 48.309580] ? perf_mmap_close+0x5cb/0xf90 [ 48.313784] ? print_usage_bug+0x480/0x480 [ 48.317985] ? find_held_lock+0x39/0x1d0 [ 48.322023] ? check_noncircular+0x20/0x20 [ 48.326226] ? perf_addr_filters_splice+0x18f/0x810 [ 48.331207] ? lock_downgrade+0x990/0x990 [ 48.335324] ? free_filters_list+0x2f0/0x2f0 [ 48.339697] ? __wake_up+0x1e/0x50 [ 48.343216] ? __lock_is_held+0xbc/0x140 [ 48.347248] mutex_lock_nested+0x16/0x20 [ 48.351276] ? mutex_lock_nested+0x16/0x20 [ 48.355476] perf_trace_destroy+0x28/0x100 [ 48.359675] ? perf_tp_event_init+0xf0/0xf0 [ 48.363970] tp_perf_event_destroy+0x15/0x20 [ 48.368344] _free_event+0x401/0x1130 [ 48.372111] ? ring_buffer_attach+0x830/0x830 [ 48.376571] ? wait_for_completion+0x770/0x770 [ 48.381127] ? ring_buffer_put+0x140/0x140 [ 48.385331] ? lock_release+0xd70/0xd70 [ 48.389269] ? atomic_dec_and_mutex_lock+0x112/0x150 [ 48.394338] ? atomic_dec_and_mutex_lock+0x112/0x150 [ 48.399409] put_event+0x24/0x30 [ 48.402739] perf_mmap_close+0x60d/0xf90 [ 48.406769] ? perf_compat_ioctl+0x70/0x70 [ 48.410969] ? save_stack_trace+0x16/0x20