INFO: task kworker/u4:2:28 blocked for more than 143 seconds. Not tainted 5.1.0-rc4-next-20190409 #21 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D26344 28 2 0x80000000 Workqueue: events_unbound fsnotify_connector_destroy_workfn Call Trace: context_switch kernel/sched/core.c:2877 [inline] __schedule+0x817/0x1cc0 kernel/sched/core.c:3518 schedule+0x92/0x180 kernel/sched/core.c:3562 schedule_timeout+0x717/0xc50 kernel/time/timer.c:1783 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x29c/0x440 kernel/sched/completion.c:136 __synchronize_srcu+0x197/0x250 kernel/rcu/srcutree.c:921 synchronize_srcu_expedited kernel/rcu/srcutree.c:946 [inline] synchronize_srcu+0x239/0x3e8 kernel/rcu/srcutree.c:997 fsnotify_connector_destroy_workfn+0x4e/0xa0 fs/notify/mark.c:177 process_one_work+0x98e/0x1790 kernel/workqueue.c:2274 worker_thread+0x98/0xe40 kernel/workqueue.c:2420 kthread+0x357/0x430 kernel/kthread.c:254 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 INFO: task kworker/u4:4:2770 blocked for more than 143 seconds. Not tainted 5.1.0-rc4-next-20190409 #21 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:4 D24448 2770 2 0x80000000 Workqueue: events_unbound fsnotify_mark_destroy_workfn Call Trace: context_switch kernel/sched/core.c:2877 [inline] __schedule+0x817/0x1cc0 kernel/sched/core.c:3518 schedule+0x92/0x180 kernel/sched/core.c:3562 schedule_timeout+0x717/0xc50 kernel/time/timer.c:1783 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x29c/0x440 kernel/sched/completion.c:136 __synchronize_srcu+0x197/0x250 kernel/rcu/srcutree.c:921 synchronize_srcu+0x2dc/0x3e8 kernel/rcu/srcutree.c:999 fsnotify_mark_destroy_workfn+0x110/0x3b0 fs/notify/mark.c:827 process_one_work+0x98e/0x1790 kernel/workqueue.c:2274 worker_thread+0x98/0xe40 kernel/workqueue.c:2420 kthread+0x357/0x430 kernel/kthread.c:254 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 INFO: task syz-executor.2:6206 blocked for more than 144 seconds. Not tainted 5.1.0-rc4-next-20190409 #21 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.2 D28232 6206 7677 0x00000004 Call Trace: context_switch kernel/sched/core.c:2877 [inline] __schedule+0x817/0x1cc0 kernel/sched/core.c:3518 schedule+0x92/0x180 kernel/sched/core.c:3562 schedule_timeout+0x717/0xc50 kernel/time/timer.c:1783 do_wait_for_common kernel/sched/completion.c:83 [inline] __wait_for_common kernel/sched/completion.c:104 [inline] wait_for_common kernel/sched/completion.c:115 [inline] wait_for_completion+0x29c/0x440 kernel/sched/completion.c:136 __synchronize_srcu+0x197/0x250 kernel/rcu/srcutree.c:921 synchronize_srcu_expedited kernel/rcu/srcutree.c:946 [inline] synchronize_srcu+0x239/0x3e8 kernel/rcu/srcutree.c:997 tracepoint_synchronize_unregister include/linux/tracepoint.h:84 [inline] perf_trace_event_unreg.isra.0+0xcb/0x220 kernel/trace/trace_event_perf.c:163 perf_trace_destroy+0xc1/0x100 kernel/trace/trace_event_perf.c:238 tp_perf_event_destroy+0x16/0x20 kernel/events/core.c:8577 _free_event+0x356/0x13b0 kernel/events/core.c:4453 put_event+0x47/0x60 kernel/events/core.c:4539 perf_event_release_kernel+0x693/0xc60 kernel/events/core.c:4645 perf_release+0x37/0x50 kernel/events/core.c:4655 __fput+0x2e5/0x8d0 fs/file_table.c:278 ____fput+0x16/0x20 fs/file_table.c:309 task_work_run+0x14a/0x1c0 kernel/task_work.c:113 tracehook_notify_resume include/linux/tracehook.h:188 [inline] exit_to_usermode_loop+0x273/0x2c0 arch/x86/entry/common.c:166 prepare_exit_to_usermode arch/x86/entry/common.c:197 [inline] syscall_return_slowpath arch/x86/entry/common.c:268 [inline] do_syscall_64+0x52d/0x610 arch/x86/entry/common.c:293 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x412071 Code: 77 24 00 01 00 00 00 c7 05 4c b6 24 00 00 00 00 00 c7 05 22 b6 24 00 00 00 00 00 c6 05 93 77 24 00 01 48 c7 05 8c 77 24 00 00 <04> 00 00 c7 05 7a 77 24 00 01 00 00 00 c7 05 00 b6 24 00 00 00 00 RSP: 002b:00007ffefd4daae0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000005 RCX: 0000000000412071 RDX: 0000000000000000 RSI: 0000000000743930 RDI: 0000000000000004 RBP: 0000000000000000 R08: ffffffff8132cbea R09: 00000000adf569c3 R10: 00007ffefd4daa10 R11: 0000000000000293 R12: 0000000000000000 R13: 00007ffefd4dab20 R14: 0000000000000000 R15: 00007ffefd4dab30 INFO: task syz-executor.0:6344 blocked for more than 144 seconds. Not tainted 5.1.0-rc4-next-20190409 #21 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.0 D28648 6344 7672 0x00000004 Call Trace: context_switch kernel/sched/core.c:2877 [inline] __schedule+0x817/0x1cc0 kernel/sched/core.c:3518 schedule+0x92/0x180 kernel/sched/core.c:3562 schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3620 __mutex_lock_common kernel/locking/mutex.c:1002 [inline] __mutex_lock+0x726/0x1310 kernel/locking/mutex.c:1072 mutex_lock_nested+0x16/0x20 kernel/locking/mutex.c:1087 perf_trace_init+0x58/0x250 kernel/trace/trace_event_perf.c:218 perf_tp_event_init+0xa6/0x120 kernel/events/core.c:8593 perf_try_init_event+0x137/0x3f0 kernel/events/core.c:10013 perf_init_event kernel/events/core.c:10060 [inline] perf_event_alloc.part.0+0xfa0/0x3200 kernel/events/core.c:10330 perf_event_alloc kernel/events/core.c:10700 [inline] __do_sys_perf_event_open+0x830/0x24e0 kernel/events/core.c:10801 __se_sys_perf_event_open kernel/events/core.c:10690 [inline] __x64_sys_perf_event_open+0xbe/0x150 kernel/events/core.c:10690 do_syscall_64+0x103/0x610 arch/x86/entry/common.c:290 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x4582b9 Code: Bad RIP value. RSP: 002b:00007ff43e23ac78 EFLAGS: 00000246 ORIG_RAX: 000000000000012a RAX: ffffffffffffffda RBX: 0000000000000005 RCX: 00000000004582b9 RDX: ffffffffffffffff RSI: 0000000000000000 RDI: 0000000020000040 RBP: 000000000073bf00 R08: 0000000000000000 R09: 0000000000000000 R10: ffffffffffffffff R11: 0000000000000246 R12: 00007ff43e23b6d4 R13: 00000000004c48de R14: 00000000004d8450 R15: 00000000ffffffff Showing all locks held in the system: 4 locks held by kworker/0:1/12: 2 locks held by kworker/u4:2/28: #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: __write_once_size include/linux/compiler.h:224 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: set_work_data kernel/workqueue.c:619 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:646 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: process_one_work+0x87e/0x1790 kernel/workqueue.c:2245 #1: 00000000de05dfd3 (connector_reaper_work){+.+.}, at: process_one_work+0x8b4/0x1790 kernel/workqueue.c:2249 1 lock held by khungtaskd/1043: #0: 0000000015f465de (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x27e kernel/locking/lockdep.c:5061 2 locks held by kworker/u4:4/2770: #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: __write_once_size include/linux/compiler.h:224 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: set_work_data kernel/workqueue.c:619 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:646 [inline] #0: 0000000054ba9239 ((wq_completion)events_unbound){+.+.}, at: process_one_work+0x87e/0x1790 kernel/workqueue.c:2245 #1: 000000002e3635cf ((reaper_work).work){+.+.}, at: process_one_work+0x8b4/0x1790 kernel/workqueue.c:2249 1 lock held by rsyslogd/7546: #0: 00000000420d9e99 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:801 2 locks held by getty/7637: #0: 00000000f8ebbeb4 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000006404d943 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7638: #0: 0000000025573640 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000c010ff5d (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7639: #0: 000000001b867203 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000003a55a2f5 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7640: #0: 00000000ef37a4e5 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000004f1aec69 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7641: #0: 000000004739f655 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000956dfc09 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7642: #0: 0000000038ca51e5 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000a2234d89 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7643: #0: 000000004bc37973 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000008cb6ba52 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 1 lock held by syz-executor.0/8345: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.0/8365: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.2/9629: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.2/9649: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.0/19964: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.0/20193: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.0/20216: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.2/32259: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 1 lock held by syz-executor.2/6206: #0: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 3 locks held by syz-executor.0/6344: #0: 00000000d932e5cf (&sig->cred_guard_mutex){+.+.}, at: __do_sys_perf_event_open+0x6d2/0x24e0 kernel/events/core.c:10781 #1: 0000000000de0498 (&pmus_srcu){....}, at: perf_event_alloc.part.0+0xd57/0x3200 kernel/events/core.c:10326 #2: 00000000fe443e74 (event_mutex){+.+.}, at: perf_trace_init+0x58/0x250 kernel/trace/trace_event_perf.c:218 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1043 Comm: khungtaskd Not tainted 5.1.0-rc4-next-20190409 #21 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Call Trace: __dump_stack lib/dump_stack.c:77 [inline] dump_stack+0x172/0x1f0 lib/dump_stack.c:113 nmi_cpu_backtrace.cold+0x63/0xa4 lib/nmi_backtrace.c:101 nmi_trigger_cpumask_backtrace+0x1be/0x236 lib/nmi_backtrace.c:62 arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:38 trigger_all_cpu_backtrace include/linux/nmi.h:146 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:204 [inline] watchdog+0x9b7/0xec0 kernel/hung_task.c:288 kthread+0x357/0x430 kernel/kthread.c:254 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: