binder: undelivered TRANSACTION_ERROR: 29189 binder: 21581:21581 transaction failed 29189/-22, size 24-8 line 2852 binder: 21580:21580 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_ERROR: 29189 INFO: task kworker/u4:1:23 blocked for more than 140 seconds. binder: 21583:21583 transaction failed 29189/-22, size 24-8 line 2852 Not tainted 4.18.0-rc5+ #152 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:1 D 8872 23 2 0x80000000 binder: 21584:21584 transaction failed 29189/-22, size 24-8 line 2852 Workqueue: events_unbound fsnotify_mark_destroy_workfn binder: undelivered TRANSACTION_ERROR: 29189 Call Trace: context_switch kernel/sched/core.c:2853 [inline] __schedule+0x87c/0x1ed0 kernel/sched/core.c:3501 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_ERROR: 29189 schedule+0xfb/0x450 kernel/sched/core.c:3545 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_ERROR: 29189 schedule_timeout+0x1cc/0x260 kernel/time/timer.c:1777 binder: undelivered TRANSACTION_ERROR: 29189 binder: 21589:21589 transaction failed 29189/-22, size 24-8 line 2852 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+0x430/0x8d0 kernel/sched/completion.c:136 binder: undelivered TRANSACTION_ERROR: 29189 binder: 21591:21591 transaction failed 29189/-22, size 24-8 line 2852 __synchronize_srcu+0x189/0x240 kernel/rcu/srcutree.c:928 binder: undelivered TRANSACTION_ERROR: 29189 binder: 21593:21593 transaction failed 29189/-22, size 24-8 line 2852 synchronize_srcu+0x41c/0x56f kernel/rcu/srcutree.c:1006 binder: 21586:21586 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 fsnotify_mark_destroy_workfn+0x1be/0x550 fs/notify/mark.c:765 binder: 21596:21596 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 process_one_work+0xc73/0x1ba0 kernel/workqueue.c:2153 binder: 21600:21600 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 binder: 21604:21604 transaction failed 29189/-22, size 24-8 line 2852 worker_thread+0x189/0x13c0 kernel/workqueue.c:2296 binder: 21594:21594 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 binder: 21598:21598 transaction failed 29189/-22, size 24-8 line 2852 kthread+0x345/0x410 kernel/kthread.c:246 binder: 21609:21609 transaction failed 29189/-22, size 24-8 line 2852 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:412 INFO: task kworker/u4:2:4740 blocked for more than 140 seconds. binder: undelivered TRANSACTION_ERROR: 29189 Not tainted 4.18.0-rc5+ #152 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. kworker/u4:2 D24912 4740 2 0x80000000 Workqueue: events_unbound fsnotify_connector_destroy_workfn binder: 21610:21610 transaction failed 29189/-22, size 24-8 line 2852 Call Trace: context_switch kernel/sched/core.c:2853 [inline] __schedule+0x87c/0x1ed0 kernel/sched/core.c:3501 binder: 21612:21612 transaction failed 29189/-22, size 24-8 line 2852 schedule+0xfb/0x450 kernel/sched/core.c:3545 binder: undelivered TRANSACTION_ERROR: 29189 schedule_timeout+0x1cc/0x260 kernel/time/timer.c:1777 binder: undelivered TRANSACTION_ERROR: 29189 binder: undelivered TRANSACTION_ERROR: 29189 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+0x430/0x8d0 kernel/sched/completion.c:136 binder: 21603:21603 transaction failed 29189/-22, size 24-8 line 2852 binder: 21602:21602 transaction failed 29189/-22, size 24-8 line 2852 __synchronize_srcu+0x189/0x240 kernel/rcu/srcutree.c:928 binder: undelivered TRANSACTION_ERROR: 29189 synchronize_srcu_expedited kernel/rcu/srcutree.c:953 [inline] synchronize_srcu+0x335/0x56f kernel/rcu/srcutree.c:1004 binder: 21619:21619 transaction failed 29189/-22, size 24-8 line 2852 binder: 21617:21617 transaction failed 29189/-22, size 24-8 line 2852 binder: 21621:21621 transaction failed 29189/-22, size 24-8 line 2852 fsnotify_connector_destroy_workfn+0x44/0xa0 fs/notify/mark.c:156 process_one_work+0xc73/0x1ba0 kernel/workqueue.c:2153 binder: 21623:21623 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 binder: 21624:21624 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 binder: 21605:21605 transaction failed 29189/-22, size 24-8 line 2852 worker_thread+0x189/0x13c0 kernel/workqueue.c:2296 binder: 21627:21627 transaction failed 29189/-22, size 24-8 line 2852 binder: 21629:21629 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 kthread+0x345/0x410 kernel/kthread.c:246 binder: 21632:21632 transaction failed 29189/-22, size 24-8 line 2852 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:412 Showing all locks held in the system: binder: 21633:21633 transaction failed 29189/-22, size 24-8 line 2852 2 locks held by kworker/u4:1/23: #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: __write_once_size include/linux/compiler.h:215 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:40 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:59 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: process_one_work+0xb44/0x1ba0 kernel/workqueue.c:2124 #1: binder: undelivered TRANSACTION_ERROR: 29189 00000000502f62bf ((reaper_work).work){+.+.}, at: process_one_work+0xb9b/0x1ba0 kernel/workqueue.c:2128 4 locks held by kworker/0:2/27: 1 lock held by khungtaskd/901: #0: 0000000076d69ef4 (rcu_read_lock){....}, at: debug_show_all_locks+0xd0/0x428 kernel/locking/lockdep.c:4461 binder: 21635:21635 transaction failed 29189/-22, size 24-8 line 2852 1 lock held by rsyslogd/4452: 2 locks held by getty/4542: #0: 0000000080c33841 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x37/0x40 drivers/tty/tty_ldsem.c:365 #1: 00000000cba20f24 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/4543: #0: 00000000d981057e (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x37/0x40 drivers/tty/tty_ldsem.c:365 binder: 21639:21639 transaction failed 29189/-22, size 24-8 line 2852 #1: 000000004ad5a4c9 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/4544: #0: 00000000c5906e08 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x37/0x40 drivers/tty/tty_ldsem.c:365 #1: 0000000066536574 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/4545: #0: 0000000064c0fcb2 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x37/0x40 drivers/tty/tty_ldsem.c:365 #1: 0000000072ec3b53 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/4546: #0: 000000009cb67601 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x37/0x40 drivers/tty/tty_ldsem.c:365 #1: 00000000af0ade0a (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/4547: #0: 0000000029b54641 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x37/0x40 drivers/tty/tty_ldsem.c:365 #1: 00000000302bb08b (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 2 locks held by getty/4548: #0: 0000000095fefa01 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x37/0x40 drivers/tty/tty_ldsem.c:365 #1: 00000000f0824818 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x335/0x1ce0 drivers/tty/n_tty.c:2140 3 locks held by syz-executor7/4597: 2 locks held by kworker/u4:2/4740: binder: undelivered TRANSACTION_ERROR: 29189 #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: __write_once_size include/linux/compiler.h:215 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: arch_atomic64_set arch/x86/include/asm/atomic64_64.h:34 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: atomic64_set include/asm-generic/atomic-instrumented.h:40 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: atomic_long_set include/asm-generic/atomic-long.h:59 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: set_work_data kernel/workqueue.c:617 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: set_work_pool_and_clear_pending kernel/workqueue.c:644 [inline] #0: 00000000268082b1 ((wq_completion)"events_unbound"){+.+.}, at: process_one_work+0xb44/0x1ba0 kernel/workqueue.c:2124 #1: 00000000ffc927e2 (connector_reaper_work){+.+.}, at: process_one_work+0xb9b/0x1ba0 kernel/workqueue.c:2128 binder: 21640:21640 transaction failed 29189/-22, size 24-8 line 2852 ============================================= NMI backtrace for cpu 1 CPU: 1 PID: 901 Comm: khungtaskd Not tainted 4.18.0-rc5+ #152 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+0x1c9/0x2b4 lib/dump_stack.c:113 binder: undelivered TRANSACTION_ERROR: 29189 nmi_cpu_backtrace.cold.4+0x19/0xce lib/nmi_backtrace.c:103 nmi_trigger_cpumask_backtrace+0x151/0x192 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:138 [inline] check_hung_uninterruptible_tasks kernel/hung_task.c:196 [inline] watchdog+0x9c4/0xf80 kernel/hung_task.c:252 binder: 21642:21642 transaction failed 29189/-22, size 24-8 line 2852 binder: undelivered TRANSACTION_ERROR: 29189 kthread+0x345/0x410 kernel/kthread.c:246 binder: undelivered TRANSACTION_ERROR: 29189 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:412 Sending NMI from CPU 1 to CPUs 0: NMI backtrace for cpu 0 CPU: 0 PID: 27 Comm: kworker/0:2 Not tainted 4.18.0-rc5+ #152 Hardware name: Google Google Compute Engine/Google Compute Engine, BIOS Google 01/01/2011 Workqueue: events binder_deferred_func RIP: 0010:memcpy+0x45/0x50 mm/kasan/kasan.c:305 Code: 48 89 de e8 3d f7 ff ff 48 8b 4d 08 48 89 de 4c 89 e7 ba 01 00 00 00 e8 29 f7 ff ff 48 89 da 4c 89 ee 4c 89 e7 e8 6b 00 d8 05 <5b> 41 5c 41 5d 5d c3 0f 1f 40 00 89 f1 b8 00 10 00 00 55 48 d3 e0 RSP: 0018:ffff8801d946ebf0 EFLAGS: 00000046 RAX: ffffffff8aa0b760 RBX: 0000000000000001 RCX: 0000000000000000 RDX: 0000000000000001 RSI: ffffffff87eb7081 RDI: ffffffff8aa0b761 RBP: ffff8801d946ec08 R08: fffffbfff15416ed R09: fffffbfff15416ec R10: fffffbfff15416ec R11: ffffffff8aa0b760 R12: ffffffff8aa0b760 R13: ffffffff87eb7080 R14: ffffffff87eb7081 R15: ffff8801d946ecc0 FS: 0000000000000000(0000) GS:ffff8801dae00000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00007fc5281522e0 CR3: 00000001ce621000 CR4: 00000000001406f0 DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000 DR3: 0000000000000000 DR6: 00000000fffe0ff0 DR7: 0000000000000400 Call Trace: memcpy include/linux/string.h:345 [inline] vsnprintf+0x527/0x1b60 lib/vsprintf.c:2229 sprintf+0xb0/0xe0 lib/vsprintf.c:2469 print_time kernel/printk/printk.c:1223 [inline] print_prefix+0x26a/0x3f0 kernel/printk/printk.c:1246 msg_print_text+0xca/0x1c0 kernel/printk/printk.c:1273 console_unlock+0x4c0/0x10b0 kernel/printk/printk.c:2363 vprintk_emit+0x6c6/0xdf0 kernel/printk/printk.c:1907 vprintk_default+0x28/0x30 kernel/printk/printk.c:1948 vprintk_func+0x7a/0xe7 kernel/printk/printk_safe.c:382 printk+0xa7/0xcf kernel/printk/printk.c:1981 binder_release_work.cold.64+0x2c/0xa2 drivers/android/binder.c:4213 binder_thread_release+0x525/0x680 drivers/android/binder.c:4401 binder_deferred_release drivers/android/binder.c:4946 [inline] binder_deferred_func+0x6d6/0x1340 drivers/android/binder.c:5029 process_one_work+0xc73/0x1ba0 kernel/workqueue.c:2153 worker_thread+0x189/0x13c0 kernel/workqueue.c:2296 kthread+0x345/0x410 kernel/kthread.c:246 ret_from_fork+0x3a/0x50 arch/x86/entry/entry_64.S:412