binder: 26822:26822 transaction failed 29189/-22, size 0-0 line 3119 binder: 26823:26823 transaction failed 29189/-22, size 0-0 line 3119 binder: 26824:26824 transaction failed 29189/-22, size 0-0 line 3119 binder: 26825:26825 transaction failed 29189/-22, size 0-0 line 3119 binder: 26826:26826 transaction failed 29189/-22, size 0-0 line 3119 INFO: task init:2066 blocked for more than 140 seconds. Not tainted 4.9.183+ #4 "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. init D29304 2066 1 0x00000000 0000000000000087 ffff88018818df00 ffff8801c967f380 ffff8801db621000 ffff88018818c740 ffff8801db621018 ffff8801881af758 ffffffff8280a5be ffff88018818e7c8 ffff88018818e7a0 00ff88018818e7d0 ffff8801db6218f0 Call Trace: [<0000000098eaffcd>] schedule+0x92/0x1c0 kernel/sched/core.c:3546 [<00000000efd8520a>] schedule_preempt_disabled+0x13/0x20 kernel/sched/core.c:3579 [<00000000ff831df2>] __mutex_lock_common kernel/locking/mutex.c:582 [inline] [<00000000ff831df2>] mutex_lock_nested+0x38d/0x920 kernel/locking/mutex.c:621 [<0000000046805f38>] tty_open_by_driver drivers/tty/tty_io.c:2062 [inline] [<0000000046805f38>] tty_open+0x3f9/0xe10 drivers/tty/tty_io.c:2140 [<000000006a33ed70>] chrdev_open+0x230/0x630 fs/char_dev.c:398 [<00000000b99fd0b8>] do_dentry_open+0x422/0xd20 fs/open.c:772 [<00000000f46d7dbf>] vfs_open+0x105/0x230 fs/open.c:885 [<000000003738c637>] do_last fs/namei.c:3457 [inline] [<000000003738c637>] path_openat+0xbf5/0x2f60 fs/namei.c:3581 [<00000000aa578e91>] do_filp_open+0x1a1/0x280 fs/namei.c:3615 [<00000000151ad84f>] do_sys_open+0x2f0/0x610 fs/open.c:1078 [<00000000c043ac45>] SYSC_open fs/open.c:1096 [inline] [<00000000c043ac45>] SyS_open+0x2d/0x40 fs/open.c:1091 [<00000000f8a73faa>] do_syscall_64+0x1ad/0x5c0 arch/x86/entry/common.c:288 [<00000000e99327c3>] entry_SYSCALL_64_after_swapgs+0x5d/0xdb Showing all locks held in the system: 2 locks held by khungtaskd/24: #0: (rcu_read_lock){......}, at: [<00000000557544f8>] check_hung_uninterruptible_tasks kernel/hung_task.c:169 [inline] #0: (rcu_read_lock){......}, at: [<00000000557544f8>] watchdog+0x14b/0xaf0 kernel/hung_task.c:263 #1: (tasklist_lock){.+.+..}, at: [<00000000185ee802>] debug_show_all_locks+0x7f/0x21f kernel/locking/lockdep.c:4336 1 lock held by rsyslogd/1908: #0: (&f->f_pos_lock){+.+.+.}, at: [<00000000ca8cb63f>] __fdget_pos+0xa8/0xd0 fs/file.c:782 2 locks held by getty/2036: #0: (&tty->ldisc_sem){++++++}, at: [<00000000d4ef0d09>] ldsem_down_read+0x33/0x40 drivers/tty/tty_ldsem.c:377 #1: (&ldata->atomic_read_lock){+.+...}, at: [<00000000fd3d8964>] n_tty_read+0x1fe/0x1820 drivers/tty/n_tty.c:2156 1 lock held by init/2066: #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open_by_driver drivers/tty/tty_io.c:2062 [inline] #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open+0x3f9/0xe10 drivers/tty/tty_io.c:2140 1 lock held by init/2067: #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open_by_driver drivers/tty/tty_io.c:2062 [inline] #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open+0x3f9/0xe10 drivers/tty/tty_io.c:2140 1 lock held by init/2068: #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open_by_driver drivers/tty/tty_io.c:2062 [inline] #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open+0x3f9/0xe10 drivers/tty/tty_io.c:2140 1 lock held by init/2069: #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open_by_driver drivers/tty/tty_io.c:2062 [inline] #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open+0x3f9/0xe10 drivers/tty/tty_io.c:2140 1 lock held by init/2070: #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open_by_driver drivers/tty/tty_io.c:2062 [inline] #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open+0x3f9/0xe10 drivers/tty/tty_io.c:2140 1 lock held by init/2071: #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open_by_driver drivers/tty/tty_io.c:2062 [inline] #0: (tty_mutex){+.+.+.}, at: [<0000000046805f38>] tty_open+0x3f9/0xe10 drivers/tty/tty_io.c:2140 ============================================= NMI backtrace for cpu 0 CPU: 0 PID: 24 Comm: khungtaskd Not tainted 4.9.183+ #4 ffff8801d98d7cc8 ffffffff81b580a1 0000000000000000 0000000000000000 0000000000000000 ffffffff81099a01 dffffc0000000000 ffff8801d98d7d00 ffffffff81b6333c 0000000000000000 0000000000000000 0000000000000000 Call Trace: [<00000000fcfb6127>] __dump_stack lib/dump_stack.c:15 [inline] [<00000000fcfb6127>] dump_stack+0xc1/0x120 lib/dump_stack.c:51 [<00000000c71d5931>] nmi_cpu_backtrace.cold+0x47/0x87 lib/nmi_backtrace.c:99 [<00000000be967217>] nmi_trigger_cpumask_backtrace+0x124/0x155 lib/nmi_backtrace.c:60 [<000000008766b35e>] arch_trigger_cpumask_backtrace+0x14/0x20 arch/x86/kernel/apic/hw_nmi.c:37 [<00000000b5410b97>] trigger_all_cpu_backtrace include/linux/nmi.h:58 [inline] [<00000000b5410b97>] check_hung_task kernel/hung_task.c:126 [inline] [<00000000b5410b97>] check_hung_uninterruptible_tasks kernel/hung_task.c:183 [inline] [<00000000b5410b97>] watchdog+0x670/0xaf0 kernel/hung_task.c:263 [<00000000420da9f3>] kthread+0x278/0x310 kernel/kthread.c:211 [<00000000be8772c4>] ret_from_fork+0x5c/0x70 arch/x86/entry/entry_64.S:375 Sending NMI from CPU 0 to CPUs 1: NMI backtrace for cpu 1 CPU: 1 PID: 23 Comm: kworker/1:1 Not tainted 4.9.183+ #4 Workqueue: events binder_deferred_funcc task: 0000000068588310 task.stack: 00000000e2b6c531 RIP: 0010:[] c [<00000000aef93a04>] io_serial_in+0x6b/0x90 drivers/tty/serial/8250/8250_port.c:414 RSP: 0018:ffff8801d9c3f648 EFLAGS: 00000002 RAX: dffffc0000000000 RBX: 00000000000003fd RCX: 0000000000000000 RDX: 00000000000003fd RSI: ffffffff81d77bd1 RDI: ffffffff84b65d18 RBP: ffff8801d9c3f658 R08: 0000000000000001 R09: 0000000000000000 R10: 0000000000000001 R11: ffffffff841d45b3 R12: ffffffff84b65ce0 R13: 0000000000000020 R14: fffffbfff096cbe3 R15: fffffbfff096cba5 FS: 0000000000000000(0000) GS:ffff8801db700000(0000) knlGS:0000000000000000 CS: 0010 DS: 0000 ES: 0000 CR0: 0000000080050033 CR2: 00000000004c36a8 CR3: 0000000003026000 CR4: 00000000001606b0 Stack: ffffffff84b65ce0c 000000000000270ac ffff8801d9c3f6a8c ffffffff81d79e74c ffffffff841d4561c ffffffff84b65d28c ffffffff84b65f1ac ffffffff841d4543c ffffffff84b65ce0c 0000000000000020c dffffc0000000000c 0000000000000020c Call Trace: [<000000001ebcc79a>] serial_in drivers/tty/serial/8250/8250.h:111 [inline] [<000000001ebcc79a>] wait_for_xmitr+0x94/0x1e0 drivers/tty/serial/8250/8250_port.c:1997 [<0000000092587811>] serial8250_console_putchar+0x20/0x60 drivers/tty/serial/8250/8250_port.c:3103 [<0000000047de9d28>] uart_console_write+0x56/0xe0 drivers/tty/serial/serial_core.c:1880 [<00000000988047d9>] serial8250_console_write+0x2fb/0x860 drivers/tty/serial/8250/8250_port.c:3169 [<000000000760f0c4>] univ8250_console_write+0x5f/0x70 drivers/tty/serial/8250/8250_core.c:594 [<000000007575319e>] call_console_drivers.isra.0.constprop.0+0x1ac/0x360 kernel/printk/printk.c:1594 [<000000006b984b23>] console_unlock+0x47c/0xb20 kernel/printk/printk.c:2454 [<0000000098ec1364>] vprintk_emit+0x43f/0x6f0 kernel/printk/printk.c:1908 [<0000000009e4cb83>] vprintk+0x28/0x30 kernel/printk/printk.c:1918 [<00000000c2669db4>] vprintk_func kernel/printk/internal.h:36 [inline] [<00000000c2669db4>] printk+0xc2/0xf5 kernel/printk/printk.c:1980 [<00000000b320728c>] binder_release_work.cold+0x78/0x9d drivers/android/binder.c:4586 [<0000000099badfc8>] binder_thread_release+0x42e/0x530 drivers/android/binder.c:4777 [<00000000cc76224d>] binder_deferred_release drivers/android/binder.c:5396 [inline] [<00000000cc76224d>] binder_deferred_func+0x499/0xde0 drivers/android/binder.c:5479 [<000000002d3a3a33>] process_one_work+0x88b/0x1600 kernel/workqueue.c:2114 [<0000000008084679>] worker_thread+0x5df/0x11d0 kernel/workqueue.c:2251 [<00000000420da9f3>] kthread+0x278/0x310 kernel/kthread.c:211 [<00000000be8772c4>] ret_from_fork+0x5c/0x70 arch/x86/entry/entry_64.S:375 Code: c24 cc9 c00 c00 c00 c49 c8d c7c c24 c38 c48 cb8 c00 c00 c00 c00 c00 cfc cff cdf c48 c89 cfa c48 cc1 cea c03 cd3 ce3 c80 c3c c02 c00 c75 c17 c41 c03 c5c c24 c38 c89 cda cec c<5b> c0f cb6 cc0 c41 c5c c5d cc3 ce8 c38 c53 c78 cff ceb cc2 ce8 c91 c53 c78 cff ceb c