TITLE: INFO: task hung in jbd2_journal_commit_transaction
TYPE: HANG

[ 1431.920513][ T1054] INFO: task jbd2/sda-8:3563 blocked for more than 140 seconds.
[ 1431.921721][ T1054]       Not tainted 4.20.0-next-20190102+ #5
[ 1431.922712][ T1054] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1431.924004][ T1054] jbd2/sda-8      D22600  3563      2 0x80000000
[ 1431.924959][ T1054] Call Trace:
[ 1431.925466][ T1054]  __schedule+0x897/0x1e60
[ 1431.932653][ T1054]  schedule+0xfe/0x350
[ 1431.936851][ T1054]  io_schedule+0x1c/0x70
[ 1431.937444][ T1054]  bit_wait_io+0x17/0x90
[ 1431.938033][ T1054]  __wait_on_bit+0xb3/0x130
[ 1431.939357][ T1054]  out_of_line_wait_on_bit+0x1f4/0x3b0
[ 1431.942911][ T1054]  __wait_on_buffer+0x6f/0x90
[ 1431.943574][ T1054]  jbd2_journal_commit_transaction+0x658a/0x8ee4
[ 1431.973827][ T1054]  kjournald2+0x20f/0xb90
[ 1431.981833][ T1054]  kthread+0x357/0x430
[ 1431.983851][ T1054]  ret_from_fork+0x3a/0x50
[ 1431.984508][ T1054] INFO: task kworker/u12:5:1980 blocked for more than 140 seconds.
[ 1431.985609][ T1054]       Not tainted 4.20.0-next-20190102+ #5
[ 1431.986435][ T1054] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1431.987627][ T1054] kworker/u12:5   D21864  1980      2 0x80000000
[ 1431.988513][ T1054] Workqueue: writeback wb_workfn (flush-8:0)
[ 1431.989343][ T1054] Call Trace:
[ 1431.989806][ T1054]  __schedule+0x897/0x1e60
[ 1431.996445][ T1054]  schedule+0xfe/0x350
[ 1431.999467][ T1054]  io_schedule+0x1c/0x70
[ 1432.000049][ T1054]  rq_qos_wait+0x2f2/0x600
[ 1432.004727][ T1054]  wbt_wait+0x266/0x430
[ 1432.007248][ T1054]  __rq_qos_throttle+0x58/0xb0
[ 1432.007889][ T1054]  blk_mq_make_request+0x424/0x1e10
[ 1432.014744][ T1054]  generic_make_request+0x902/0x17f0
[ 1432.019946][ T1054]  submit_bio+0xba/0x480
[ 1432.021946][ T1054]  ext4_io_submit+0x197/0x230
[ 1432.022621][ T1054]  ext4_writepages+0x139d/0x4180
[ 1432.032498][ T1054]  do_writepages+0x99/0x1a0
[ 1432.033840][ T1054]  __writeback_single_inode+0x1c5/0x1620
[ 1432.043200][ T1054]  writeback_sb_inodes+0x762/0x1260
[ 1432.048996][ T1054]  __writeback_inodes_wb+0x16d/0x3d0
[ 1432.051205][ T1054]  wb_writeback+0xa2d/0xf70
[ 1432.059220][ T1054]  wb_workfn+0xccc/0x16f0
[ 1432.068135][ T1054]  process_one_work+0xd0c/0x1ce0
[ 1432.077047][ T1054]  worker_thread+0x143/0x14a0
[ 1432.087752][ T1054]  kthread+0x357/0x430
[ 1432.089635][ T1054]  ret_from_fork+0x3a/0x50
[ 1432.090262][ T1054] INFO: task syz-executor2:6677 blocked for more than 140 seconds.
[ 1432.091339][ T1054]       Not tainted 4.20.0-next-20190102+ #5
[ 1432.092141][ T1054] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1432.093322][ T1054] syz-executor2   D19624  6677  22450 0x00000004
[ 1432.094200][ T1054] Call Trace:
[ 1432.094662][ T1054]  __schedule+0x897/0x1e60
[ 1432.099160][ T1054]  schedule+0xfe/0x350
[ 1432.104857][ T1054]  io_schedule+0x1c/0x70
[ 1432.105440][ T1054]  wait_on_page_bit_common+0xad5/0x1370
[ 1432.112856][ T1054]  __filemap_fdatawait_range+0x614/0x890
[ 1432.119095][ T1054]  file_write_and_wait_range+0xd1/0x100
[ 1432.119844][ T1054]  ext4_sync_file+0x2da/0x14d0
[ 1432.123727][ T1054]  vfs_fsync_range+0x144/0x230
[ 1432.124362][ T1054]  ext4_file_write_iter+0x683/0x1400
[ 1432.135479][ T1054]  do_iter_readv_writev+0x902/0xbc0
[ 1432.138406][ T1054]  do_iter_write+0x184/0x610
[ 1432.141349][ T1054]  vfs_iter_write+0x77/0xb0
[ 1432.141973][ T1054]  iter_file_splice_write+0x885/0xfc0
[ 1432.145035][ T1054]  direct_splice_actor+0x126/0x1a0
[ 1432.145746][ T1054]  splice_direct_to_actor+0x3be/0x9d0
[ 1432.149420][ T1054]  do_splice_direct+0x2c7/0x420
[ 1432.153962][ T1054]  do_sendfile+0x61a/0xe60
[ 1432.156833][ T1054]  __x64_sys_sendfile64+0x15a/0x240
[ 1432.159760][ T1054]  do_syscall_64+0x1a3/0x800
[ 1432.163622][ T1054]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[ 1432.164427][ T1054] RIP: 0033:0x4576a9
[ 1432.164967][ T1054] Code: 3b 41 10 76 7d 48 81 ec 88 00 00 00 48 89 ac 24 80 00 00 00 48 8d ac 24 80 00 00 00 48 8b 59 20 48 85 db 75 67 48 8b b4 24 a0 <00> 00 00 8b 8c 24 a8 00 00 00 48 89 e7 f3 a4 48 8b 94 24 98 00 00
[ 1432.167624][ T1054] RSP: 002b:00007f66fbce3c88 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
[ 1432.168774][ T1054] RAX: ffffffffffffffda RBX: 000000000071bf00 RCX: 00000000004576a9
[ 1432.169895][ T1054] RDX: 0000000020000040 RSI: 0000000000000005 RDI: 0000000000000005
[ 1432.171034][ T1054] RBP: 0000000000000004 R08: 0000000000000000 R09: 0000000000000000
[ 1432.172145][ T1054] R10: 00008080fffffffe R11: 0000000000000246 R12: 00007f66fbce46d4
[ 1432.173246][ T1054] R13: 00000000004abcac R14: 00000000006eb9b8 R15: 00000000ffffffff
[ 1432.174341][ T1054] INFO: task syz-executor2:6693 blocked for more than 140 seconds.
[ 1432.175408][ T1054]       Not tainted 4.20.0-next-20190102+ #5
[ 1432.176221][ T1054] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 1432.177401][ T1054] syz-executor2   D22200  6693  22450 0x00000004
[ 1432.178275][ T1054] Call Trace:
[ 1432.178737][ T1054]  __schedule+0x897/0x1e60
[ 1432.183888][ T1054]  schedule+0xfe/0x350
[ 1432.187237][ T1054]  jbd2_log_wait_commit+0x320/0x4b0
[ 1432.190123][ T1054]  jbd2_complete_transaction+0x18c/0x1e0
[ 1432.190947][ T1054]  ext4_sync_file+0x1211/0x14d0
[ 1432.194899][ T1054]  vfs_fsync_range+0x144/0x230
[ 1432.195553][ T1054]  ext4_file_write_iter+0x683/0x1400
[ 1432.206634][ T1054]  do_iter_readv_writev+0x902/0xbc0
[ 1432.209498][ T1054]  do_iter_write+0x184/0x610
[ 1432.212321][ T1054]  vfs_iter_write+0x77/0xb0
[ 1432.212930][ T1054]  iter_file_splice_write+0x885/0xfc0
[ 1432.215944][ T1054]  direct_splice_actor+0x126/0x1a0
[ 1432.216657][ T1054]  splice_direct_to_actor+0x3be/0x9d0
[ 1432.220393][ T1054]  do_splice_direct+0x2c7/0x420
[ 1432.224944][ T1054]  do_sendfile+0x61a/0xe60
[ 1432.227770][ T1054]  __x64_sys_sendfile64+0x15a/0x240
[ 1432.229896][ T1054]  do_syscall_64+0x1a3/0x800
[ 1432.233503][ T1054]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[ 1432.234327][ T1054] RIP: 0033:0x4576a9
[ 1432.234875][ T1054] Code: 3b 41 10 76 7d 48 81 ec 88 00 00 00 48 89 ac 24 80 00 00 00 48 8d ac 24 80 00 00 00 48 8b 59 20 48 85 db 75 67 48 8b b4 24 a0 <00> 00 00 8b 8c 24 a8 00 00 00 48 89 e7 f3 a4 48 8b 94 24 98 00 00
[ 1432.237487][ T1054] RSP: 002b:00007f66fbcc2c88 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
[ 1432.238606][ T1054] RAX: ffffffffffffffda RBX: 000000000071bfa0 RCX: 00000000004576a9
[ 1432.240004][ T1054] RDX: 0000000020000380 RSI: 0000000000000005 RDI: 0000000000000005
[ 1432.241148][ T1054] RBP: 0000000000000004 R08: 0000000000000000 R09: 0000000000000000
[ 1432.242318][ T1054] R10: 0001000000020000 R11: 0000000000000246 R12: 00007f66fbcc36d4
[ 1432.243807][ T1054] R13: 00000000004abcac R14: 00000000006eb9b8 R15: 00000000ffffffff
[ 1432.245419][ T1054] 
[ 1432.245419][ T1054] Showing all locks held in the system:
[ 1432.246771][ T1054] 1 lock held by khungtaskd/1054:
[ 1432.247458][ T1054]  #0: 00000000c542499d (rcu_read_lock){....}, at: debug_show_all_locks+0xc6/0x41d
[ 1432.248686][ T1054] 1 lock held by rsyslogd/5859:
[ 1432.249607][ T1054]  #0: 00000000567e80cf (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1b3/0x1f0
[ 1432.251067][ T1054] 2 locks held by getty/5951:
[ 1432.251698][ T1054]  #0: 000000003b0dfac2 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
[ 1432.252896][ T1054]  #1: 00000000281ebc43 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
[ 1432.254207][ T1054] 2 locks held by getty/5952:
[ 1432.254995][ T1054]  #0: 00000000f0d48c91 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
[ 1432.256190][ T1054]  #1: 00000000cff3c1fb (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
[ 1432.257467][ T1054] 2 locks held by getty/5953:
[ 1432.258082][ T1054]  #0: 00000000cb353a8f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
[ 1432.259287][ T1054]  #1: 00000000373ded25 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
[ 1432.260651][ T1054] 2 locks held by getty/5954:
[ 1432.261313][ T1054]  #0: 000000005c8be537 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
[ 1432.262536][ T1054]  #1: 00000000d7aec815 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
[ 1432.263836][ T1054] 2 locks held by getty/5955:
[ 1432.264474][ T1054]  #0: 00000000eda8138a (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
[ 1432.265680][ T1054]  #1: 00000000f4fd60a6 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
[ 1432.266973][ T1054] 2 locks held by getty/5956:
[ 1432.267617][ T1054]  #0: 000000000745b5fb (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
[ 1432.268834][ T1054]  #1: 00000000a4c3442a (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
[ 1432.270143][ T1054] 2 locks held by getty/5957:
[ 1432.270818][ T1054]  #0: 000000002cb7c49e (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
[ 1432.272044][ T1054]  #1: 000000009258e26f (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
[ 1432.273373][ T1054] 4 locks held by kworker/u12:5/1980:
[ 1432.274102][ T1054]  #0: 000000005e902bc8 ((wq_completion)"writeback"){+.+.}, at: process_one_work+0xbc7/0x1ce0
[ 1432.275494][ T1054]  #1: 0000000056cd520a ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0xc1d/0x1ce0
[ 1432.277027][ T1054]  #2: 00000000146ba37b (&type->s_umount_key#30){++++}, at: trylock_super+0x22/0x110
[ 1432.278316][ T1054]  #3: 00000000fec9c2c2 (&sbi->s_journal_flag_rwsem){.+.+}, at: do_writepages+0x99/0x1a0
[ 1432.279643][ T1054] 1 lock held by syz-executor2/6677:
[ 1432.280377][ T1054]  #0: 000000007b67e744 (sb_writers#3){.+.+}, at: do_sendfile+0xad7/0xe60
[ 1432.281560][ T1054] 1 lock held by syz-executor2/6693:
[ 1432.282283][ T1054]  #0: 000000007b67e744 (sb_writers#3){.+.+}, at: do_sendfile+0xad7/0xe60
[ 1432.283458][ T1054] 
[ 1432.283784][ T1054] =============================================
[ 1432.283784][ T1054] 
[ 1432.284927][ T1054] NMI backtrace for cpu 3
[ 1432.285533][ T1054] CPU: 3 PID: 1054 Comm: khungtaskd Not tainted 4.20.0-next-20190102+ #5
[ 1432.286668][ T1054] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 1432.287906][ T1054] Call Trace:
[ 1432.288362][ T1054]  dump_stack+0x1db/0x2d0
[ 1432.290598][ T1054]  nmi_cpu_backtrace.cold+0x63/0xa4
[ 1432.292117][ T1054]  nmi_trigger_cpumask_backtrace+0x1be/0x236
[ 1432.292936][ T1054]  arch_trigger_cpumask_backtrace+0x14/0x20
[ 1432.293741][ T1054]  watchdog+0xbbb/0x1170
[ 1432.304325][ T1054]  kthread+0x357/0x430
[ 1432.306510][ T1054]  ret_from_fork+0x3a/0x50
[ 1432.307177][ T1054] Sending NMI from CPU 3 to CPUs 0-2:
[ 1432.307971][    C0] NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x2/0x10
[ 1432.307978][    C2] NMI backtrace for cpu 2 skipped: idling at native_safe_halt+0x2/0x10
[ 1432.308914][    C1] NMI backtrace for cpu 1
[ 1432.308920][    C1] CPU: 1 PID: 5857 Comm: rs:main Q:Reg Not tainted 4.20.0-next-20190102+ #5
[ 1432.308926][    C1] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 1432.308930][    C1] RIP: 0010:unwind_next_frame+0x36/0x50
[ 1432.308941][    C1] Code: fa 55 48 c1 ea 03 48 89 e5 48 83 ec 08 0f b6 14 02 48 89 f8 83 e0 07 83 c0 03 38 d0 7c 04 84 d2 75 0f 8b 17 31 c0 85 d2 74 05 <e8> 35 f5 ff ff c9 c3 48 89 7d f8 e8 aa 54 8e 00 48 8b 7d f8 eb e2
[ 1432.308945][    C1] RSP: 0018:ffff88805f667100 EFLAGS: 00000202
[ 1432.308953][    C1] RAX: 0000000000000000 RBX: ffff88805f6671b8 RCX: 000000000000000f
[ 1432.308958][    C1] RDX: 0000000000000001 RSI: ffffffff8100c393 RDI: ffff88805f667118
[ 1432.308963][    C1] RBP: ffff88805f667108 R08: 0000000000000001 R09: ffff88805f667168
[ 1432.308968][    C1] R10: ffff88805f667140 R11: ffff88805f667150 R12: 0000000000000000
[ 1432.308973][    C1] R13: 0000000000000000 R14: ffff88805c5d2500 R15: ffff8880664f37c0
[ 1432.308979][    C1] FS:  00007fc30a025700(0000) GS:ffff88806c440000(0000) knlGS:0000000000000000
[ 1432.308983][    C1] CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
[ 1432.308989][    C1] CR2: 00007f8d9477b190 CR3: 000000006300b001 CR4: 00000000001606e0
[ 1432.308992][    C1] Call Trace:
[ 1432.308995][    C1]  __save_stack_trace+0x7a/0xf0
[ 1432.309002][    C1]  save_stack_trace+0x1a/0x20
[ 1432.309006][    C1]  save_stack+0x45/0xd0
[ 1432.309125][    C1]  kasan_kmalloc+0xcf/0xe0
[ 1432.309128][    C1]  kasan_slab_alloc+0xf/0x20
[ 1432.309132][    C1]  kmem_cache_alloc+0x12d/0x710
[ 1432.309136][    C1]  jbd2__journal_start+0x1e4/0xa80
[ 1432.309147][    C1]  __ext4_journal_start_sb+0x1a7/0x630
[ 1432.309163][    C1]  ext4_da_write_begin+0x4ee/0x12d0
[ 1432.309206][    C1]  generic_perform_write+0x2a0/0x6b0
[ 1432.309226][    C1]  __generic_file_write_iter+0x25e/0x630
[ 1432.309229][    C1]  ext4_file_write_iter+0x381/0x1400
[ 1432.309263][    C1]  __vfs_write+0x764/0xb40
[ 1432.309286][    C1]  vfs_write+0x20c/0x580
[ 1432.309290][    C1]  ksys_write+0x105/0x260
[ 1432.309309][    C1]  __x64_sys_write+0x73/0xb0
[ 1432.309312][    C1]  do_syscall_64+0x1a3/0x800
[ 1432.309328][    C1]  entry_SYSCALL_64_after_hwframe+0x49/0xbe
[ 1432.309332][    C1] RIP: 0033:0x7fc30ba8319d
[ 1432.309343][    C1] Code: d1 20 00 00 75 10 b8 01 00 00 00 0f 05 48 3d 01 f0 ff ff 73 31 c3 48 83 ec 08 e8 be fa ff ff 48 89 04 24 b8 01 00 00 00 0f 05 <48> 8b 3c 24 48 89 c2 e8 07 fb ff ff 48 89 d0 48 83 c4 08 48 3d 01
[ 1432.309347][    C1] RSP: 002b:00007fc30a023f90 EFLAGS: 00000293 ORIG_RAX: 0000000000000001
[ 1432.309356][    C1] RAX: ffffffffffffffda RBX: 0000000000000400 RCX: 00007fc30ba8319d
[ 1432.309361][    C1] RDX: 0000000000000400 RSI: 00000000008d3ce0 RDI: 0000000000000002
[ 1432.309366][    C1] RBP: 00000000008d3ce0 R08: 00000000008d408d R09: 00007fc30b3ffe07
[ 1432.309372][    C1] R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000000
[ 1432.309377][    C1] R13: 00007fc30a024410 R14: 00007fc304002a50 R15: 00000000008d3ac0
[ 1432.309388][ T1054] Kernel panic - not syncing: hung_task: blocked tasks
[ 1432.400481][ T1054] CPU: 3 PID: 1054 Comm: khungtaskd Not tainted 4.20.0-next-20190102+ #5
[ 1432.401805][ T1054] Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
[ 1432.403220][ T1054] Call Trace:
[ 1432.403719][ T1054]  dump_stack+0x1db/0x2d0
[ 1432.405283][ T1054]  panic+0x2cb/0x65c
[ 1432.411432][ T1054]  watchdog+0xbcc/0x1170
[ 1432.420886][ T1054]  kthread+0x357/0x430
[ 1432.422972][ T1054]  ret_from_fork+0x3a/0x50
[ 1432.423910][ T1054] Dumping ftrace buffer:
[ 1432.424680][ T1054]    (ftrace buffer empty)
[ 1432.425305][ T1054] Kernel Offset: disabled
[ 1432.425916][ T1054] Rebooting in 86400 seconds..

REPORT:
INFO: task jbd2/sda-8:3563 blocked for more than 140 seconds.
      Not tainted 4.20.0-next-20190102+ #5
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
jbd2/sda-8      D22600  3563      2 0x80000000
Call Trace:
 __schedule+0x897/0x1e60
 schedule+0xfe/0x350
 io_schedule+0x1c/0x70
 bit_wait_io+0x17/0x90
 __wait_on_bit+0xb3/0x130
 out_of_line_wait_on_bit+0x1f4/0x3b0
 __wait_on_buffer+0x6f/0x90
 jbd2_journal_commit_transaction+0x658a/0x8ee4
 kjournald2+0x20f/0xb90
 kthread+0x357/0x430
 ret_from_fork+0x3a/0x50
INFO: task kworker/u12:5:1980 blocked for more than 140 seconds.
      Not tainted 4.20.0-next-20190102+ #5
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
kworker/u12:5   D21864  1980      2 0x80000000
Workqueue: writeback wb_workfn (flush-8:0)
Call Trace:
 __schedule+0x897/0x1e60
 schedule+0xfe/0x350
 io_schedule+0x1c/0x70
 rq_qos_wait+0x2f2/0x600
 wbt_wait+0x266/0x430
 __rq_qos_throttle+0x58/0xb0
 blk_mq_make_request+0x424/0x1e10
 generic_make_request+0x902/0x17f0
 submit_bio+0xba/0x480
 ext4_io_submit+0x197/0x230
 ext4_writepages+0x139d/0x4180
 do_writepages+0x99/0x1a0
 __writeback_single_inode+0x1c5/0x1620
 writeback_sb_inodes+0x762/0x1260
 __writeback_inodes_wb+0x16d/0x3d0
 wb_writeback+0xa2d/0xf70
 wb_workfn+0xccc/0x16f0
 process_one_work+0xd0c/0x1ce0
 worker_thread+0x143/0x14a0
 kthread+0x357/0x430
 ret_from_fork+0x3a/0x50
INFO: task syz-executor2:6677 blocked for more than 140 seconds.
      Not tainted 4.20.0-next-20190102+ #5
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor2   D19624  6677  22450 0x00000004
Call Trace:
 __schedule+0x897/0x1e60
 schedule+0xfe/0x350
 io_schedule+0x1c/0x70
 wait_on_page_bit_common+0xad5/0x1370
 __filemap_fdatawait_range+0x614/0x890
 file_write_and_wait_range+0xd1/0x100
 ext4_sync_file+0x2da/0x14d0
 vfs_fsync_range+0x144/0x230
 ext4_file_write_iter+0x683/0x1400
 do_iter_readv_writev+0x902/0xbc0
 do_iter_write+0x184/0x610
 vfs_iter_write+0x77/0xb0
 iter_file_splice_write+0x885/0xfc0
 direct_splice_actor+0x126/0x1a0
 splice_direct_to_actor+0x3be/0x9d0
 do_splice_direct+0x2c7/0x420
 do_sendfile+0x61a/0xe60
 __x64_sys_sendfile64+0x15a/0x240
 do_syscall_64+0x1a3/0x800
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x4576a9
Code: 3b 41 10 76 7d 48 81 ec 88 00 00 00 48 89 ac 24 80 00 00 00 48 8d ac 24 80 00 00 00 48 8b 59 20 48 85 db 75 67 48 8b b4 24 a0 <00> 00 00 8b 8c 24 a8 00 00 00 48 89 e7 f3 a4 48 8b 94 24 98 00 00
RSP: 002b:00007f66fbce3c88 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 000000000071bf00 RCX: 00000000004576a9
RDX: 0000000020000040 RSI: 0000000000000005 RDI: 0000000000000005
RBP: 0000000000000004 R08: 0000000000000000 R09: 0000000000000000
R10: 00008080fffffffe R11: 0000000000000246 R12: 00007f66fbce46d4
R13: 00000000004abcac R14: 00000000006eb9b8 R15: 00000000ffffffff
INFO: task syz-executor2:6693 blocked for more than 140 seconds.
      Not tainted 4.20.0-next-20190102+ #5
"echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
syz-executor2   D22200  6693  22450 0x00000004
Call Trace:
 __schedule+0x897/0x1e60
 schedule+0xfe/0x350
 jbd2_log_wait_commit+0x320/0x4b0
 jbd2_complete_transaction+0x18c/0x1e0
 ext4_sync_file+0x1211/0x14d0
 vfs_fsync_range+0x144/0x230
 ext4_file_write_iter+0x683/0x1400
 do_iter_readv_writev+0x902/0xbc0
 do_iter_write+0x184/0x610
 vfs_iter_write+0x77/0xb0
 iter_file_splice_write+0x885/0xfc0
 direct_splice_actor+0x126/0x1a0
 splice_direct_to_actor+0x3be/0x9d0
 do_splice_direct+0x2c7/0x420
 do_sendfile+0x61a/0xe60
 __x64_sys_sendfile64+0x15a/0x240
 do_syscall_64+0x1a3/0x800
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x4576a9
Code: 3b 41 10 76 7d 48 81 ec 88 00 00 00 48 89 ac 24 80 00 00 00 48 8d ac 24 80 00 00 00 48 8b 59 20 48 85 db 75 67 48 8b b4 24 a0 <00> 00 00 8b 8c 24 a8 00 00 00 48 89 e7 f3 a4 48 8b 94 24 98 00 00
RSP: 002b:00007f66fbcc2c88 EFLAGS: 00000246 ORIG_RAX: 0000000000000028
RAX: ffffffffffffffda RBX: 000000000071bfa0 RCX: 00000000004576a9
RDX: 0000000020000380 RSI: 0000000000000005 RDI: 0000000000000005
RBP: 0000000000000004 R08: 0000000000000000 R09: 0000000000000000
R10: 0001000000020000 R11: 0000000000000246 R12: 00007f66fbcc36d4
R13: 00000000004abcac R14: 00000000006eb9b8 R15: 00000000ffffffff

Showing all locks held in the system:
1 lock held by khungtaskd/1054:
 #0: 00000000c542499d (rcu_read_lock){....}, at: debug_show_all_locks+0xc6/0x41d
1 lock held by rsyslogd/5859:
 #0: 00000000567e80cf (&f->f_pos_lock){+.+.}, at: __fdget_pos+0x1b3/0x1f0
2 locks held by getty/5951:
 #0: 000000003b0dfac2 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
 #1: 00000000281ebc43 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
2 locks held by getty/5952:
 #0: 00000000f0d48c91 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
 #1: 00000000cff3c1fb (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
2 locks held by getty/5953:
 #0: 00000000cb353a8f (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
 #1: 00000000373ded25 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
2 locks held by getty/5954:
 #0: 000000005c8be537 (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
 #1: 00000000d7aec815 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
2 locks held by getty/5955:
 #0: 00000000eda8138a (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
 #1: 00000000f4fd60a6 (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
2 locks held by getty/5956:
 #0: 000000000745b5fb (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
 #1: 00000000a4c3442a (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
2 locks held by getty/5957:
 #0: 000000002cb7c49e (&tty->ldisc_sem){++++}, at: ldsem_down_read+0x33/0x40
 #1: 000000009258e26f (&ldata->atomic_read_lock){+.+.}, at: n_tty_read+0x30a/0x1eb0
4 locks held by kworker/u12:5/1980:
 #0: 000000005e902bc8 ((wq_completion)"writeback"){+.+.}, at: process_one_work+0xbc7/0x1ce0
 #1: 0000000056cd520a ((work_completion)(&(&wb->dwork)->work)){+.+.}, at: process_one_work+0xc1d/0x1ce0
 #2: 00000000146ba37b (&type->s_umount_key#30){++++}, at: trylock_super+0x22/0x110
 #3: 00000000fec9c2c2 (&sbi->s_journal_flag_rwsem){.+.+}, at: do_writepages+0x99/0x1a0
1 lock held by syz-executor2/6677:
 #0: 000000007b67e744 (sb_writers#3){.+.+}, at: do_sendfile+0xad7/0xe60
1 lock held by syz-executor2/6693:
 #0: 000000007b67e744 (sb_writers#3){.+.+}, at: do_sendfile+0xad7/0xe60

=============================================

NMI backtrace for cpu 3
CPU: 3 PID: 1054 Comm: khungtaskd Not tainted 4.20.0-next-20190102+ #5
Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
Call Trace:
 dump_stack+0x1db/0x2d0
 nmi_cpu_backtrace.cold+0x63/0xa4
 nmi_trigger_cpumask_backtrace+0x1be/0x236
 arch_trigger_cpumask_backtrace+0x14/0x20
 watchdog+0xbbb/0x1170
 kthread+0x357/0x430
 ret_from_fork+0x3a/0x50
Sending NMI from CPU 3 to CPUs 0-2:
NMI backtrace for cpu 0 skipped: idling at native_safe_halt+0x2/0x10
NMI backtrace for cpu 2 skipped: idling at native_safe_halt+0x2/0x10
NMI backtrace for cpu 1
CPU: 1 PID: 5857 Comm: rs:main Q:Reg Not tainted 4.20.0-next-20190102+ #5
Hardware name: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1 04/01/2014
RIP: 0010:unwind_next_frame+0x36/0x50
Code: fa 55 48 c1 ea 03 48 89 e5 48 83 ec 08 0f b6 14 02 48 89 f8 83 e0 07 83 c0 03 38 d0 7c 04 84 d2 75 0f 8b 17 31 c0 85 d2 74 05 <e8> 35 f5 ff ff c9 c3 48 89 7d f8 e8 aa 54 8e 00 48 8b 7d f8 eb e2
RSP: 0018:ffff88805f667100 EFLAGS: 00000202
RAX: 0000000000000000 RBX: ffff88805f6671b8 RCX: 000000000000000f
RDX: 0000000000000001 RSI: ffffffff8100c393 RDI: ffff88805f667118
RBP: ffff88805f667108 R08: 0000000000000001 R09: ffff88805f667168
R10: ffff88805f667140 R11: ffff88805f667150 R12: 0000000000000000
R13: 0000000000000000 R14: ffff88805c5d2500 R15: ffff8880664f37c0
FS:  00007fc30a025700(0000) GS:ffff88806c440000(0000) knlGS:0000000000000000
CS:  0010 DS: 0000 ES: 0000 CR0: 0000000080050033
CR2: 00007f8d9477b190 CR3: 000000006300b001 CR4: 00000000001606e0
Call Trace:
 __save_stack_trace+0x7a/0xf0
 save_stack_trace+0x1a/0x20
 save_stack+0x45/0xd0
 kasan_kmalloc+0xcf/0xe0
 kasan_slab_alloc+0xf/0x20
 kmem_cache_alloc+0x12d/0x710
 jbd2__journal_start+0x1e4/0xa80
 __ext4_journal_start_sb+0x1a7/0x630
 ext4_da_write_begin+0x4ee/0x12d0
 generic_perform_write+0x2a0/0x6b0
 __generic_file_write_iter+0x25e/0x630
 ext4_file_write_iter+0x381/0x1400
 __vfs_write+0x764/0xb40
 vfs_write+0x20c/0x580
 ksys_write+0x105/0x260
 __x64_sys_write+0x73/0xb0
 do_syscall_64+0x1a3/0x800
 entry_SYSCALL_64_after_hwframe+0x49/0xbe
RIP: 0033:0x7fc30ba8319d
Code: d1 20 00 00 75 10 b8 01 00 00 00 0f 05 48 3d 01 f0 ff ff 73 31 c3 48 83 ec 08 e8 be fa ff ff 48 89 04 24 b8 01 00 00 00 0f 05 <48> 8b 3c 24 48 89 c2 e8 07 fb ff ff 48 89 d0 48 83 c4 08 48 3d 01
RSP: 002b:00007fc30a023f90 EFLAGS: 00000293 ORIG_RAX: 0000000000000001
RAX: ffffffffffffffda RBX: 0000000000000400 RCX: 00007fc30ba8319d
RDX: 0000000000000400 RSI: 00000000008d3ce0 RDI: 0000000000000002
RBP: 00000000008d3ce0 R08: 00000000008d408d R09: 00007fc30b3ffe07
R10: 0000000000000000 R11: 0000000000000293 R12: 0000000000000000
R13: 00007fc30a024410 R14: 00007fc304002a50 R15: 00000000008d3ac0