INFO: task kworker/u4:2:15149 blocked for more than 143 seconds. Not tainted 5.2.0-rc3-next-20190607 #11 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D27080 15149 2 0x80004000 Workqueue: events_unbound fsnotify_mark_destroy_workfn Call Trace: context_switch kernel/sched/core.c:2818 [inline] __schedule+0x7c5/0x1560 kernel/sched/core.c:3444 schedule+0xa8/0x260 kernel/sched/core.c:3508 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:819 process_one_work+0x989/0x1790 kernel/workqueue.c:2269 worker_thread+0x98/0xe40 kernel/workqueue.c:2415 kthread+0x354/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 INFO: task kworker/u4:3:15153 blocked for more than 143 seconds. Not tainted 5.2.0-rc3-next-20190607 #11 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:3 D24520 15153 2 0x80004000 Workqueue: events_unbound fsnotify_connector_destroy_workfn Call Trace: context_switch kernel/sched/core.c:2818 [inline] __schedule+0x7c5/0x1560 kernel/sched/core.c:3444 schedule+0xa8/0x260 kernel/sched/core.c:3508 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:164 process_one_work+0x989/0x1790 kernel/workqueue.c:2269 worker_thread+0x98/0xe40 kernel/workqueue.c:2415 kthread+0x354/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 INFO: task syz-executor.1:23431 can't die for more than 144 seconds. syz-executor.1 D28264 23431 9020 0x00004004 Call Trace: context_switch kernel/sched/core.c:2818 [inline] __schedule+0x7c5/0x1560 kernel/sched/core.c:3444 schedule+0xa8/0x260 kernel/sched/core.c:3508 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+0xc6/0x220 kernel/trace/trace_event_perf.c:163 perf_trace_destroy+0xbc/0x100 kernel/trace/trace_event_perf.c:238 tp_perf_event_destroy+0x16/0x20 kernel/events/core.c:8620 _free_event+0x354/0x13a0 kernel/events/core.c:4464 put_event+0x47/0x60 kernel/events/core.c:4550 perf_event_release_kernel+0x693/0xbe0 kernel/events/core.c:4656 perf_release+0x37/0x50 kernel/events/core.c:4666 __fput+0x2ff/0x890 fs/file_table.c:280 ____fput+0x16/0x20 fs/file_table.c:313 task_work_run+0x145/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:168 prepare_exit_to_usermode arch/x86/entry/common.c:199 [inline] syscall_return_slowpath arch/x86/entry/common.c:279 [inline] do_syscall_64+0x58e/0x680 arch/x86/entry/common.c:304 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x412f61 Code: 00 00 00 00 00 80 3b 2d 0f 84 cb 02 00 00 8b 05 59 a7 24 00 89 85 e4 00 00 00 48 c7 85 18 01 00 00 00 00 00 00 0f b6 03 3c 2f <0f> 87 69 01 00 00 3c 2e 0f 82 c1 01 00 00 be 01 00 00 00 4c 89 e7 RSP: 002b:00007ffc2b145ee0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000006 RCX: 0000000000412f61 RDX: fffffffffffffff7 RSI: 0000000000000000 RDI: 0000000000000005 RBP: 0000000000000001 R08: 00000000c260e35f R09: 00000000c260e363 R10: 00007ffc2b145fc0 R11: 0000000000000293 R12: 000000000075c920 R13: 000000000075c920 R14: 00000000002d5edd R15: 000000000075c06c INFO: task syz-executor.1:23431 blocked for more than 144 seconds. Not tainted 5.2.0-rc3-next-20190607 #11 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. syz-executor.1 D28264 23431 9020 0x00004004 Call Trace: context_switch kernel/sched/core.c:2818 [inline] __schedule+0x7c5/0x1560 kernel/sched/core.c:3444 schedule+0xa8/0x260 kernel/sched/core.c:3508 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+0xc6/0x220 kernel/trace/trace_event_perf.c:163 perf_trace_destroy+0xbc/0x100 kernel/trace/trace_event_perf.c:238 tp_perf_event_destroy+0x16/0x20 kernel/events/core.c:8620 _free_event+0x354/0x13a0 kernel/events/core.c:4464 put_event+0x47/0x60 kernel/events/core.c:4550 perf_event_release_kernel+0x693/0xbe0 kernel/events/core.c:4656 perf_release+0x37/0x50 kernel/events/core.c:4666 __fput+0x2ff/0x890 fs/file_table.c:280 ____fput+0x16/0x20 fs/file_table.c:313 task_work_run+0x145/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:168 prepare_exit_to_usermode arch/x86/entry/common.c:199 [inline] syscall_return_slowpath arch/x86/entry/common.c:279 [inline] do_syscall_64+0x58e/0x680 arch/x86/entry/common.c:304 entry_SYSCALL_64_after_hwframe+0x49/0xbe RIP: 0033:0x412f61 Code: 00 00 00 00 00 80 3b 2d 0f 84 cb 02 00 00 8b 05 59 a7 24 00 89 85 e4 00 00 00 48 c7 85 18 01 00 00 00 00 00 00 0f b6 03 3c 2f <0f> 87 69 01 00 00 3c 2e 0f 82 c1 01 00 00 be 01 00 00 00 4c 89 e7 RSP: 002b:00007ffc2b145ee0 EFLAGS: 00000293 ORIG_RAX: 0000000000000003 RAX: 0000000000000000 RBX: 0000000000000006 RCX: 0000000000412f61 RDX: fffffffffffffff7 RSI: 0000000000000000 RDI: 0000000000000005 RBP: 0000000000000001 R08: 00000000c260e35f R09: 00000000c260e363 R10: 00007ffc2b145fc0 R11: 0000000000000293 R12: 000000000075c920 R13: 000000000075c920 R14: 00000000002d5edd R15: 000000000075c06c Showing all locks held in the system: 1 lock held by khungtaskd/1046: #0: 00000000eb084022 (rcu_read_lock){....}, at: debug_show_all_locks+0x5f/0x27e kernel/locking/lockdep.c:5262 4 locks held by rs:main Q:Reg/8885: 1 lock held by rsyslogd/8887: #0: 00000000d5c9a6d3 (&f->f_pos_lock){+.+.}, at: __fdget_pos+0xee/0x110 fs/file.c:801 2 locks held by getty/8977: #0: 000000002623ba56 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000fc5124db (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/8978: #0: 000000002a53a3d3 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000a509c286 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/8979: #0: 00000000c39b632b (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000003944ede2 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/8980: #0: 00000000eee0d6c6 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000d1d56ac1 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/8981: #0: 0000000008d78099 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 00000000a1e7e8cf (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/8982: #0: 000000005ef3e241 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 000000004f1c5863 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 2 locks held by getty/8983: #0: 000000002e464293 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:341 #1: 0000000036512bf7 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x232/0x1b70 drivers/tty/n_tty.c:2156 3 locks held by kworker/u4:0/32699: #0: 00000000880c955d (&rq->lock){-.-.}, at: rq_lock kernel/sched/sched.h:1158 [inline] #0: 00000000880c955d (&rq->lock){-.-.}, at: __schedule+0x1f5/0x1560 kernel/sched/core.c:3396 #1: 00000000eb084022 (rcu_read_lock){....}, at: trace_sched_stat_runtime include/trace/events/sched.h:435 [inline] #1: 00000000eb084022 (rcu_read_lock){....}, at: update_curr+0x2ce/0x8a0 kernel/sched/fair.c:842 #2: 00000000afec23a1 (&base->lock){-.-.}, at: lock_timer_base+0x56/0x1b0 kernel/time/timer.c:932 2 locks held by kworker/u4:2/15149: #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: __write_once_size include/linux/compiler.h:221 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: set_work_data kernel/workqueue.c:620 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:647 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: process_one_work+0x87e/0x1790 kernel/workqueue.c:2240 #1: 000000001c2a8d6a ((reaper_work).work){+.+.}, at: process_one_work+0x8b4/0x1790 kernel/workqueue.c:2244 2 locks held by kworker/u4:3/15153: #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: __write_once_size include/linux/compiler.h:221 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:855 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:40 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: set_work_data kernel/workqueue.c:620 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:647 [inline] #0: 000000009219851b ((wq_completion)events_unbound){+.+.}, at: process_one_work+0x87e/0x1790 kernel/workqueue.c:2240 #1: 0000000094291096 (connector_reaper_work){+.+.}, at: process_one_work+0x8b4/0x1790 kernel/workqueue.c:2244 3 locks held by kworker/0:3/20906: 1 lock held by syz-executor.1/23431: #0: 00000000cc64268c (event_mutex){+.+.}, at: perf_trace_destroy+0x28/0x100 kernel/trace/trace_event_perf.c:236 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 1046 Comm: khungtaskd Not tainted 5.2.0-rc3-next-20190607 #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:249 [inline] watchdog+0xb88/0x12b0 kernel/hung_task.c:333 kthread+0x354/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 20906 Comm: kworker/0:3 Not tainted 5.2.0-rc3-next-20190607 #11 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: events rtc_timer_do_work RIP: 0010:__sanitizer_cov_trace_pc+0x4/0x50 kernel/kcov.c:98 Code: 15 09 41 bc f4 ff ff ff e8 fd fa e9 ff 48 c7 05 8e e5 15 09 00 00 00 00 e9 a4 e9 ff ff 90 90 90 90 90 90 90 90 90 55 48 89 e5 <48> 8b 75 08 65 48 8b 04 25 c0 fd 01 00 65 8b 15 b0 1f 91 7e 81 e2 RSP: 0018:ffff88805c87fb50 EFLAGS: 00000213 RAX: 0000000000000000 RBX: ffff88809f92b188 RCX: ffffffff871e3891 RDX: ffff88809f92b188 RSI: 0000000000000001 RDI: 0000000000000006 RBP: ffff88805c87fb50 R08: ffff88805437e3c0 R09: ffffed1015d06be0 R10: ffffed1015d06bdf R11: ffff8880ae835efb R12: ffff88809f92b138 R13: 0000000000000001 R14: dffffc0000000000 R15: 17871c7c8d465400 FS: 0000000000000000(0000) GS:ffff8880ae800000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: ffffffffff600400 CR3: 000000009d0b9000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000600 Call Trace: timerqueue_del+0x4f/0x150 lib/timerqueue.c:69 rtc_timer_do_work+0x2d0/0xeb0 drivers/rtc/interface.c:899 process_one_work+0x989/0x1790 kernel/workqueue.c:2269 worker_thread+0x98/0xe40 kernel/workqueue.c:2415 kthread+0x354/0x420 kernel/kthread.c:255 ret_from_fork+0x24/0x30 arch/x86/entry/entry_64.S:352