INFO: task kworker/u4:2:38 blocked for more than 143 seconds. Not tainted 5.1.0-rc2-next-20190326 #11 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D27112 38 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:925 synchronize_srcu+0x2dc/0x3e8 kernel/rcu/srcutree.c:1003 fsnotify_mark_destroy_workfn+0x110/0x3b0 fs/notify/mark.c:827 process_one_work+0x98e/0x1790 kernel/workqueue.c:2270 worker_thread+0x98/0xe40 kernel/workqueue.c:2416 kthread+0x357/0x430 kernel/kthread.c:253 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 INFO: task kworker/u4:4:2567 blocked for more than 143 seconds. Not tainted 5.1.0-rc2-next-20190326 #11 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:4 D25688 2567 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:925 synchronize_srcu+0x2dc/0x3e8 kernel/rcu/srcutree.c:1003 fsnotify_connector_destroy_workfn+0x4e/0xa0 fs/notify/mark.c:177 process_one_work+0x98e/0x1790 kernel/workqueue.c:2270 process_scheduled_works kernel/workqueue.c:2332 [inline] worker_thread+0x7be/0xe40 kernel/workqueue.c:2418 kthread+0x357/0x430 kernel/kthread.c:253 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 INFO: task syz-executor.3:14012 blocked for more than 144 seconds. Not tainted 5.1.0-rc2-next-20190326 #11 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.3 D28184 14012 7654 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:925 synchronize_srcu_expedited kernel/rcu/srcutree.c:950 [inline] synchronize_srcu+0x239/0x3e8 kernel/rcu/srcutree.c:1001 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:0x411fc1 Code: ff 85 c0 75 0c 48 c7 03 c0 22 41 00 e9 a6 fe ff ff be 4c 37 44 00 48 89 ef e8 1b 94 ff ff 85 c0 75 0c 48 c7 03 f0 22 41 00 e9 <89> fe ff ff 31 c0 48 89 ee bf 30 31 44 00 e8 5c f0 00 00 b8 14 fc RSP: 002b:00007ffd4c0c77e0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 000000000000000a RCX: 0000000000411fc1 RDX: 0000000000000000 RSI: 0000000000740b38 RDI: 0000000000000009 RBP: 0000000000000000 R08: 000000000006e34f R09: 000000000006e34f R10: 00007ffd4c0c7710 R11: 0000000000000293 R12: 0000000000000001 R13: 00007ffd4c0c7820 R14: 0000000000000000 R15: 00007ffd4c0c7830 Showing all locks held in the system: 2 locks held by kworker/u4:2/38: #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: __write_once_size include/linux/compiler.h:224 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: set_work_data kernel/workqueue.c:619 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:646 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: process_one_work+0x87e/0x1790 kernel/workqueue.c:2241 #1: 00000000e3f4f73d ((reaper_work).work){+.+.}, at: process_one_work+0x8b4/0x1790 kernel/workqueue.c:2245 1 lock held by khungtaskd/1043: #0: 000000003fb65d07 (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x27e kernel/locking/lockdep.c:5061 2 locks held by kworker/u4:4/2567: #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: __write_once_size include/linux/compiler.h:224 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: set_work_data kernel/workqueue.c:619 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:646 [inline] #0: 00000000d1481626 ((wq_completion)events_unbound){+.+.}, at: process_one_work+0x87e/0x1790 kernel/workqueue.c:2241 #1: 0000000006f6611c (connector_reaper_work){+.+.}, at: process_one_work+0x8b4/0x1790 kernel/workqueue.c:2245 1 lock held by rsyslogd/7516: #0: 00000000f9b6caa3 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:801 2 locks held by getty/7606: #0: 0000000047b3fd73 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000005c0cfb74 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7607: #0: 00000000207fe58d (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000738a64cb (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7608: #0: 000000007b0291b6 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000004f1a2ec0 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7609: #0: 00000000f390188e (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000f7b3dd38 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7610: #0: 00000000b6c7ef30 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000652ad8cb (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7611: #0: 00000000ad5b9fd6 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000091fa963 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/7612: #0: 00000000d208a36b (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000ddb773f3 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 3 locks held by kworker/0:4/7655: 1 lock held by syz-executor.3/14012: #0: 00000000c4b12ac1 (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1043 Comm: khungtaskd Not tainted 5.1.0-rc2-next-20190326 #11 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:253 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: