io-uring stressor from ubuntu_stress_smoke_test hangs on AWS instances

Bug #2070342 reported by Po-Hsu Lin
6
This bug affects 1 person
Affects Status Importance Assigned to Milestone
ubuntu-kernel-tests
New
Undecided
Unassigned

Bug Description

io-uring stressor will hang with the latest stress-ng. This issue can only be found on AWS c3.xlarge, c4.large instances, with Ubuntu Jammy / Mantic / Noble kernels.

Test output with J-5.15.0-112:

$ sudo ./stress-ng -v -t 5 --io-uring 4 --io-uring-ops 3000 --ignite-cpu --syslog --verbose --verify --oomable
stress-ng: debug: [1282] invoked with './stress-ng -v -t 5 --io-uring 4 --io-uring-ops 3000 --ignite-cpu --syslog --verbose --verify --oomable' by user 0 'root'
stress-ng: debug: [1282] stress-ng 0.18.00 g5be042abcc7b
stress-ng: debug: [1282] system: Linux ip-172-31-41-225 5.15.0-112-generic #122-Ubuntu SMP Thu May 23 07:48:21 UTC 2024 x86_64, gcc 11.4.0, glibc 2.35, little endian
stress-ng: debug: [1282] RAM total: 3.6G, RAM free: 3.2G, swap free: 0.0
stress-ng: debug: [1282] temporary file path: '/home/ubuntu/stress-ng', filesystem type: ext2 (6720506 blocks available)
stress-ng: debug: [1282] CPUs have 2 idle states: C1, POLL
stress-ng: debug: [1282] 2 processors online, 2 processors configured
stress-ng: info: [1282] setting to a 5 secs run per stressor
stress-ng: debug: [1282] CPU data cache: L1: 32K, L2: 256K, L3: 25600K
stress-ng: debug: [1282] cache allocate: shared cache buffer size: 25600K
stress-ng: info: [1282] dispatching hogs: 4 io-uring
stress-ng: debug: [1282] starting stressors
stress-ng: debug: [1283] io-uring: [1283] started (instance 0 on CPU 1)
stress-ng: debug: [1282] 4 stressors started
stress-ng: debug: [1285] io-uring: [1285] started (instance 2 on CPU 0)
stress-ng: debug: [1286] io-uring: [1286] started (instance 3 on CPU 1)
stress-ng: debug: [1284] io-uring: [1284] started (instance 1 on CPU 0)
stress-ng: warn: [1283] cannot terminate process 1287, gave up after 120 seconds
stress-ng: warn: [1284] cannot terminate process 1290, gave up after 120 seconds
stress-ng: debug: [1284] io-uring: [1284] exited (instance 1 on CPU 0)
stress-ng: warn: [1286] cannot terminate process 1289, gave up after 120 seconds
stress-ng: debug: [1286] io-uring: [1286] exited (instance 3 on CPU 0)
stress-ng: warn: [1285] cannot terminate process 1288, gave up after 120 seconds
stress-ng: debug: [1285] io-uring: [1285] exited (instance 2 on CPU 0)
stress-ng: debug: [1283] io-uring: [1283] exited (instance 0 on CPU 0)
stress-ng: debug: [1282] io-uring: [1283] terminated (success)
stress-ng: debug: [1282] io-uring: removing temporary files in ./tmp-stress-ng-io-uring-1283-0

syslog:

[ 484.045024] INFO: task systemd:1 blocked for more than 120 seconds.
[ 484.046289] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.047408] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.048961] task:systemd state:D stack: 0 pid: 1 ppid: 0 flags:0x00000002
[ 484.048965] Call Trace:
[ 484.048967] <TASK>
[ 484.048970] __schedule+0x24e/0x590
[ 484.048976] ? bit_wait+0x70/0x70
[ 484.048979] schedule+0x69/0x110
[ 484.048982] io_schedule+0x46/0x80
[ 484.048993] bit_wait_io+0x11/0x70
[ 484.048996] __wait_on_bit+0x34/0xa0
[ 484.048998] out_of_line_wait_on_bit+0x8d/0xb0
[ 484.049002] ? var_wake_function+0x30/0x30
[ 484.049006] do_get_write_access+0x243/0x3b0
[ 484.049011] jbd2_journal_get_write_access+0x6e/0x90
[ 484.049014] __ext4_journal_get_write_access+0x8f/0x1b0
[ 484.049017] __ext4_new_inode+0x3ee/0x14b0
[ 484.049022] ? ext4_lookup.part.0+0x120/0x230
[ 484.049026] ext4_mkdir+0x157/0x330
[ 484.049029] vfs_mkdir+0xb0/0x150
[ 484.049033] do_mkdirat+0x128/0x160
[ 484.049036] __x64_sys_mkdir+0x4c/0x70
[ 484.049039] x64_sys_call+0x94/0x1fa0
[ 484.049044] do_syscall_64+0x56/0xb0
[ 484.049048] ? syscall_exit_to_user_mode+0x35/0x50
[ 484.049051] ? x64_sys_call+0x1866/0x1fa0
[ 484.049054] ? do_syscall_64+0x63/0xb0
[ 484.049057] ? x64_sys_call+0x1de6/0x1fa0
[ 484.049060] ? do_syscall_64+0x63/0xb0
[ 484.049063] ? do_syscall_64+0x63/0xb0
[ 484.049066] entry_SYSCALL_64_after_hwframe+0x67/0xd1
[ 484.049071] RIP: 0033:0x7eff89eb745b
[ 484.049074] RSP: 002b:00007ffdc9f8a268 EFLAGS: 00000212 ORIG_RAX: 0000000000000053
[ 484.049077] RAX: ffffffffffffffda RBX: f49998db0aa753ff RCX: 00007eff89eb745b
[ 484.049079] RDX: 0000000000000030 RSI: 00000000000001c0 RDI: 0000555b727d07a0
[ 484.049080] RBP: 00000000b504f32d R08: 0000000000000004 R09: 0000000000000001
[ 484.049082] R10: 0000000663a83b5c R11: 0000000000000212 R12: 27bb2ee687b0b0fd
[ 484.049084] R13: 0000555b727d07a0 R14: 00007eff89f7fc00 R15: 00000000006cee2a
[ 484.049087] </TASK>
[ 484.049089] INFO: task kworker/u30:0:9 blocked for more than 120 seconds.
[ 484.050421] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.051530] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.053090] task:kworker/u30:0 state:D stack: 0 pid: 9 ppid: 2 flags:0x00004000
[ 484.053094] Workqueue: writeback wb_workfn (flush-202:0)
[ 484.053100] Call Trace:
[ 484.053102] <TASK>
[ 484.053103] __schedule+0x24e/0x590
[ 484.053108] schedule+0x69/0x110
[ 484.053111] io_schedule+0x46/0x80
[ 484.053114] ? wbt_cleanup_cb+0x20/0x20
[ 484.053117] rq_qos_wait+0xd0/0x170
[ 484.053121] ? elv_merge+0xb0/0xe0
[ 484.053125] ? wbt_rqw_done+0x110/0x110
[ 484.053127] ? sysv68_partition+0x280/0x280
[ 484.053130] ? wbt_cleanup_cb+0x20/0x20
[ 484.053133] wbt_wait+0x9f/0xf0
[ 484.053135] __rq_qos_throttle+0x28/0x40
[ 484.053138] blk_mq_submit_bio+0x127/0x610
[ 484.053143] __submit_bio+0x1ee/0x220
[ 484.053147] submit_bio_noacct+0xc0/0x120
[ 484.053150] submit_bio+0x4a/0x130
[ 484.053153] ext4_bio_write_page+0x208/0x530
[ 484.053157] mpage_submit_page+0x4c/0x80
[ 484.053160] mpage_process_page_bufs+0x169/0x180
[ 484.053162] mpage_prepare_extent_to_map+0x215/0x360
[ 484.053166] ext4_writepages+0x212/0x870
[ 484.053170] ? select_idle_core+0x135/0x260
[ 484.053174] ? cpumask_next_wrap+0x33/0x90
[ 484.053179] do_writepages+0xd7/0x200
[ 484.053182] ? mpage_map_and_submit_extent+0x4f0/0x4f0
[ 484.053185] ? do_writepages+0xd7/0x200
[ 484.053188] ? _raw_spin_unlock_irqrestore+0xe/0x30
[ 484.053191] ? fprop_fraction_percpu+0x34/0x80
[ 484.053193] ? __wb_calc_thresh+0x3e/0x130
[ 484.053196] __writeback_single_inode+0x44/0x290
[ 484.053199] writeback_sb_inodes+0x22a/0x500
[ 484.053203] __writeback_inodes_wb+0x56/0xf0
[ 484.053206] wb_writeback+0x1cc/0x290
[ 484.053209] wb_do_writeback+0x1f8/0x280
[ 484.053212] wb_workfn+0x77/0x260
[ 484.053215] ? _raw_spin_unlock_irqrestore+0xe/0x30
[ 484.053217] ? try_to_wake_up+0x65/0x5a0
[ 484.053221] ? raw_spin_rq_unlock+0x10/0x30
[ 484.053224] process_one_work+0x22b/0x3d0
[ 484.053227] worker_thread+0x53/0x420
[ 484.053229] ? process_one_work+0x3d0/0x3d0
[ 484.053231] kthread+0x12a/0x150
[ 484.053234] ? set_kthread_struct+0x50/0x50
[ 484.053237] ret_from_fork+0x22/0x30
[ 484.053241] </TASK>
[ 484.053247] INFO: task kworker/u30:3:106 blocked for more than 120 seconds.
[ 484.054614] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.055730] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.057275] task:kworker/u30:3 state:D stack: 0 pid: 106 ppid: 2 flags:0x00004000
[ 484.057279] Workqueue: writeback wb_workfn (flush-202:0)
[ 484.057283] Call Trace:
[ 484.057284] <TASK>
[ 484.057285] __schedule+0x24e/0x590
[ 484.057289] ? bit_wait+0x70/0x70
[ 484.057292] schedule+0x69/0x110
[ 484.057295] io_schedule+0x46/0x80
[ 484.057298] bit_wait_io+0x11/0x70
[ 484.057301] __wait_on_bit+0x34/0xa0
[ 484.057305] out_of_line_wait_on_bit+0x8d/0xb0
[ 484.057309] ? var_wake_function+0x30/0x30
[ 484.057313] do_get_write_access+0x243/0x3b0
[ 484.057317] jbd2_journal_get_write_access+0x6e/0x90
[ 484.057320] __ext4_journal_get_write_access+0x8f/0x1b0
[ 484.057324] ext4_mb_mark_diskspace_used+0x102/0x3b0
[ 484.057328] ext4_mb_new_blocks+0x333/0x560
[ 484.057332] ext4_ext_map_blocks+0x64d/0x920
[ 484.057336] ext4_map_blocks+0x19a/0x5c0
[ 484.057339] ? ext4_alloc_io_end_vec+0x1e/0x60
[ 484.057341] mpage_map_and_submit_extent+0xb3/0x4f0
[ 484.057345] ext4_writepages+0x660/0x870
[ 484.057349] ? update_sd_lb_stats.constprop.0+0xf2/0x390
[ 484.057354] do_writepages+0xd7/0x200
[ 484.057357] ? mpage_map_and_submit_extent+0x4f0/0x4f0
[ 484.057360] ? do_writepages+0xd7/0x200
[ 484.057362] ? __percpu_counter_sum+0x6f/0xa0
[ 484.057367] ? fprop_fraction_percpu+0x34/0x80
[ 484.057370] ? __wb_calc_thresh+0x3e/0x130
[ 484.057373] __writeback_single_inode+0x44/0x290
[ 484.057376] writeback_sb_inodes+0x22a/0x500
[ 484.057381] __writeback_inodes_wb+0x56/0xf0
[ 484.057384] wb_writeback+0x1cc/0x290
[ 484.057387] wb_do_writeback+0x1f8/0x280
[ 484.057391] wb_workfn+0x77/0x260
[ 484.057393] ? psi_task_switch+0x1eb/0x220
[ 484.057396] ? raw_spin_rq_unlock+0x10/0x30
[ 484.057399] ? finish_task_switch.isra.0+0x7e/0x280
[ 484.057402] process_one_work+0x22b/0x3d0
[ 484.057405] worker_thread+0x53/0x420
[ 484.057407] ? process_one_work+0x3d0/0x3d0
[ 484.057409] kthread+0x12a/0x150
[ 484.057412] ? set_kthread_struct+0x50/0x50
[ 484.057415] ret_from_fork+0x22/0x30
[ 484.057419] </TASK>
[ 484.057421] INFO: task jbd2/xvda1-8:294 blocked for more than 120 seconds.
[ 484.058763] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.059876] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.061421] task:jbd2/xvda1-8 state:D stack: 0 pid: 294 ppid: 2 flags:0x00004000
[ 484.061424] Call Trace:
[ 484.061425] <TASK>
[ 484.061426] __schedule+0x24e/0x590
[ 484.061430] ? bit_wait+0x70/0x70
[ 484.061433] schedule+0x69/0x110
[ 484.061436] io_schedule+0x46/0x80
[ 484.061439] bit_wait_io+0x11/0x70
[ 484.061443] __wait_on_bit+0x34/0xa0
[ 484.061447] out_of_line_wait_on_bit+0x8d/0xb0
[ 484.061451] ? var_wake_function+0x30/0x30
[ 484.061454] __wait_on_buffer+0x34/0x40
[ 484.061458] jbd2_journal_commit_transaction+0xea3/0x1670
[ 484.061463] kjournald2+0xa9/0x280
[ 484.061466] ? wait_woken+0x70/0x70
[ 484.061469] ? load_superblock.part.0+0xc0/0xc0
[ 484.061473] kthread+0x12a/0x150
[ 484.061476] ? set_kthread_struct+0x50/0x50
[ 484.061479] ret_from_fork+0x22/0x30
[ 484.061483] </TASK>
[ 484.061485] INFO: task systemd-journal:367 blocked for more than 120 seconds.
[ 484.062882] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.063998] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.065548] task:systemd-journal state:D stack: 0 pid: 367 ppid: 1 flags:0x00000002
[ 484.065551] Call Trace:
[ 484.065552] <TASK>
[ 484.065554] __schedule+0x24e/0x590
[ 484.065558] ? bit_wait+0x70/0x70
[ 484.065561] schedule+0x69/0x110
[ 484.065564] io_schedule+0x46/0x80
[ 484.065568] bit_wait_io+0x11/0x70
[ 484.065571] __wait_on_bit+0x34/0xa0
[ 484.065574] out_of_line_wait_on_bit+0x8d/0xb0
[ 484.065578] ? var_wake_function+0x30/0x30
[ 484.065580] do_get_write_access+0x243/0x3b0
[ 484.065583] jbd2_journal_get_write_access+0x6e/0x90
[ 484.065586] __ext4_journal_get_write_access+0x8f/0x1b0
[ 484.065589] ext4_orphan_add+0x11c/0x300
[ 484.065591] ? __ext4_journal_start_sb+0x10b/0x130
[ 484.065594] ext4_truncate+0x155/0x470
[ 484.065597] ext4_setattr+0x58f/0x960
[ 484.065599] ? ext4_xattr_get+0x8b/0xd0
[ 484.065603] notify_change+0x3b3/0x550
[ 484.065606] do_truncate+0x83/0xe0
[ 484.065609] ? do_truncate+0x83/0xe0
[ 484.065612] do_sys_ftruncate+0x165/0x1a0
[ 484.065615] __x64_sys_ftruncate+0x1a/0x20
[ 484.065617] x64_sys_call+0x1f67/0x1fa0
[ 484.065620] do_syscall_64+0x56/0xb0
[ 484.065623] ? x64_sys_call+0x18b3/0x1fa0
[ 484.065626] ? do_syscall_64+0x63/0xb0
[ 484.065629] entry_SYSCALL_64_after_hwframe+0x67/0xd1
[ 484.065632] RIP: 0033:0x7fdb30236fbb
[ 484.065634] RSP: 002b:00007fff6b5d3e18 EFLAGS: 00000206 ORIG_RAX: 000000000000004d
[ 484.065637] RAX: ffffffffffffffda RBX: 00007fff6b5d3e60 RCX: 00007fdb30236fbb
[ 484.065639] RDX: 000055d31f5acc80 RSI: 0000000000800000 RDI: 0000000000000017
[ 484.065640] RBP: 000055d31f5b3b50 R08: 0000000000000001 R09: 000055d31f5b3bd4
[ 484.065642] R10: 0000000000000010 R11: 0000000000000206 R12: 000055d31f589310
[ 484.065643] R13: 00007fff6b5d3e58 R14: 0000000000000003 R15: 0000000000000000
[ 484.065646] </TASK>
[ 484.065655] INFO: task stress-ng-io-ur:1287 blocked for more than 120 seconds.
[ 484.067070] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.068179] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.069729] task:stress-ng-io-ur state:D stack: 0 pid: 1287 ppid: 1 flags:0x00000006
[ 484.069732] Call Trace:
[ 484.069733] <TASK>
[ 484.069735] __schedule+0x24e/0x590
[ 484.069738] ? path_parentat+0x4c/0x90
[ 484.069742] schedule+0x69/0x110
[ 484.069744] rwsem_down_write_slowpath+0x230/0x3e0
[ 484.069749] down_write+0x47/0x60
[ 484.069751] vfs_unlink+0x50/0x290
[ 484.069754] do_unlinkat+0x19e/0x2c0
[ 484.069757] __x64_sys_unlink+0x42/0x70
[ 484.069760] x64_sys_call+0x16c4/0x1fa0
[ 484.069763] do_syscall_64+0x56/0xb0
[ 484.069767] ? do_syscall_64+0x63/0xb0
[ 484.069770] ? do_syscall_64+0x63/0xb0
[ 484.069773] ? do_syscall_64+0x63/0xb0
[ 484.069776] entry_SYSCALL_64_after_hwframe+0x67/0xd1
[ 484.069780] RIP: 0033:0x7fe36d6a70ab
[ 484.069782] RSP: 002b:00007fffa66cbff8 EFLAGS: 00000246 ORIG_RAX: 0000000000000057
[ 484.069784] RAX: ffffffffffffffda RBX: 0000557fef023888 RCX: 00007fe36d6a70ab
[ 484.069786] RDX: 0000000000000000 RSI: 0000000000004000 RDI: 00007fffa66cc260
[ 484.069788] RBP: 00007fffa66cc260 R08: 00007fe36b83f000 R09: 00007fffa66cbe30
[ 484.069790] R10: 0000000000000001 R11: 0000000000000246 R12: 0000000000000000
[ 484.069791] R13: 000000000000007b R14: 00007fffa66cc060 R15: 00007fffa66cc260
[ 484.069794] </TASK>
[ 484.069795] INFO: task iou-wrk-1287:1293 blocked for more than 120 seconds.
[ 484.071161] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.072275] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.073816] task:iou-wrk-1287 state:D stack: 0 pid: 1293 ppid: 1 flags:0x00024006
[ 484.073820] Call Trace:
[ 484.073821] <TASK>
[ 484.073822] __schedule+0x24e/0x590
[ 484.073827] schedule+0x69/0x110
[ 484.073830] jbd2_log_wait_commit+0xaf/0x120
[ 484.073834] ? wait_woken+0x70/0x70
[ 484.073837] jbd2_complete_transaction+0x64/0xb0
[ 484.073840] ext4_fc_commit+0x19a/0x1d0
[ 484.073842] ext4_sync_file+0x304/0x330
[ 484.073846] vfs_fsync_range+0x49/0x90
[ 484.073849] io_issue_sqe+0xc51/0x13f0
[ 484.073853] io_wq_submit_work+0x8d/0xf0
[ 484.073856] io_worker_handle_work+0x100/0x2b0
[ 484.073859] io_wqe_worker+0x2c3/0x320
[ 484.073863] ? raw_spin_rq_unlock+0x10/0x30
[ 484.073866] ? finish_task_switch.isra.0+0x7e/0x280
[ 484.073869] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.073872] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.073876] ret_from_fork+0x22/0x30
[ 484.073878] RIP: 0033:0x0
[ 484.073880] RSP: 002b:0000000000000000 EFLAGS: 00000246 ORIG_RAX: 00000000000001aa
[ 484.073882] RAX: 0000000000000000 RBX: 00007fffa66cc0a0 RCX: 00007fe36d6af88d
[ 484.073884] RDX: 0000000000000001 RSI: 0000000000000001 RDI: 0000000000000004
[ 484.073885] RBP: 00007fe36b83d000 R08: 0000000000000000 R09: 0000000000000000
[ 484.073887] R10: 0000000000000001 R11: 0000000000000246 R12: 00007fe36d5783a8
[ 484.073888] R13: 0000557fef023888 R14: 0000557fef02de37 R15: 0000557fef2da500
[ 484.073891] </TASK>
[ 484.073892] INFO: task iou-wrk-1287:1294 blocked for more than 120 seconds.
[ 484.075248] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.076360] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.077910] task:iou-wrk-1287 state:D stack: 0 pid: 1294 ppid: 1 flags:0x00024006
[ 484.077913] Call Trace:
[ 484.077914] <TASK>
[ 484.077915] __schedule+0x24e/0x590
[ 484.077918] schedule+0x69/0x110
[ 484.077922] rwsem_down_write_slowpath+0x230/0x3e0
[ 484.077925] ? aa_file_perm+0x127/0x2a0
[ 484.077928] down_write+0x47/0x60
[ 484.077931] ext4_fallocate+0x61/0x300
[ 484.077934] vfs_fallocate+0x155/0x300
[ 484.077937] io_issue_sqe+0xf13/0x13f0
[ 484.077941] io_wq_submit_work+0x8d/0xf0
[ 484.077945] io_worker_handle_work+0x100/0x2b0
[ 484.077950] io_wqe_worker+0x2c3/0x320
[ 484.077954] ? raw_spin_rq_unlock+0x10/0x30
[ 484.077957] ? finish_task_switch.isra.0+0x7e/0x280
[ 484.077960] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.077964] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.077968] ret_from_fork+0x22/0x30
[ 484.077971] RIP: 0033:0x0
[ 484.077972] RSP: 002b:0000000000000000 EFLAGS: 00000246 ORIG_RAX: 00000000000001aa
[ 484.077974] RAX: 0000000000000000 RBX: 00007fffa66cc0a0 RCX: 00007fe36d6af88d
[ 484.077976] RDX: 0000000000000001 RSI: 0000000000000001 RDI: 0000000000000004
[ 484.077977] RBP: 00007fe36b83d000 R08: 0000000000000000 R09: 0000000000000000
[ 484.077979] R10: 0000000000000001 R11: 0000000000000246 R12: 00007fe36d5783a8
[ 484.077980] R13: 0000557fef023888 R14: 0000557fef02de37 R15: 0000557fef2da500
[ 484.077983] </TASK>
[ 484.077984] INFO: task iou-wrk-1287:1295 blocked for more than 120 seconds.
[ 484.079351] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.080477] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.082015] task:iou-wrk-1287 state:D stack: 0 pid: 1295 ppid: 1 flags:0x00024006
[ 484.082018] Call Trace:
[ 484.082019] <TASK>
[ 484.082020] __schedule+0x24e/0x590
[ 484.082024] schedule+0x69/0x110
[ 484.082027] jbd2_log_wait_commit+0xaf/0x120
[ 484.082030] ? wait_woken+0x70/0x70
[ 484.082033] jbd2_complete_transaction+0x64/0xb0
[ 484.082035] ext4_fc_commit+0x19a/0x1d0
[ 484.082037] ext4_sync_file+0x304/0x330
[ 484.082040] vfs_fsync_range+0x49/0x90
[ 484.082043] io_issue_sqe+0xc51/0x13f0
[ 484.082046] ? __schedule+0x256/0x590
[ 484.082049] io_wq_submit_work+0x8d/0xf0
[ 484.082052] io_worker_handle_work+0x100/0x2b0
[ 484.082056] io_wqe_worker+0x2c3/0x320
[ 484.082060] ? raw_spin_rq_unlock+0x10/0x30
[ 484.082062] ? finish_task_switch.isra.0+0x7e/0x280
[ 484.082065] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.082068] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.082071] ret_from_fork+0x22/0x30
[ 484.082074] RIP: 0033:0x0
[ 484.082076] RSP: 002b:0000000000000000 EFLAGS: 00000246 ORIG_RAX: 00000000000001aa
[ 484.082078] RAX: 0000000000000000 RBX: 00007fffa66cc0a0 RCX: 00007fe36d6af88d
[ 484.082079] RDX: 0000000000000001 RSI: 0000000000000001 RDI: 0000000000000004
[ 484.082080] RBP: 00007fe36b83d000 R08: 0000000000000000 R09: 0000000000000000
[ 484.082082] R10: 0000000000000001 R11: 0000000000000246 R12: 00007fe36d5783a8
[ 484.082083] R13: 0000557fef023888 R14: 0000557fef02de37 R15: 0000557fef2da500
[ 484.082086] </TASK>
[ 484.082087] INFO: task iou-wrk-1287:1296 blocked for more than 120 seconds.
[ 484.083461] Not tainted 5.15.0-112-generic #122-Ubuntu
[ 484.084602] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 484.086133] task:iou-wrk-1287 state:D stack: 0 pid: 1296 ppid: 1 flags:0x00024006
[ 484.086136] Call Trace:
[ 484.086137] <TASK>
[ 484.086138] __schedule+0x24e/0x590
[ 484.086142] schedule+0x69/0x110
[ 484.086145] rwsem_down_write_slowpath+0x230/0x3e0
[ 484.086148] ? aa_file_perm+0x127/0x2a0
[ 484.086152] down_write+0x47/0x60
[ 484.086154] ext4_fallocate+0x61/0x300
[ 484.086157] vfs_fallocate+0x155/0x300
[ 484.086159] io_issue_sqe+0xf13/0x13f0
[ 484.086163] io_wq_submit_work+0x8d/0xf0
[ 484.086166] io_worker_handle_work+0x100/0x2b0
[ 484.086169] io_wqe_worker+0x2c3/0x320
[ 484.086173] ? raw_spin_rq_unlock+0x10/0x30
[ 484.086175] ? finish_task_switch.isra.0+0x7e/0x280
[ 484.086178] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.086181] ? io_worker_handle_work+0x2b0/0x2b0
[ 484.086184] ret_from_fork+0x22/0x30
[ 484.086187] RIP: 0033:0x0
[ 484.086189] RSP: 002b:0000000000000000 EFLAGS: 00000246 ORIG_RAX: 00000000000001aa
[ 484.086191] RAX: 0000000000000000 RBX: 00007fffa66cc0a0 RCX: 00007fe36d6af88d
[ 484.086192] RDX: 0000000000000001 RSI: 0000000000000001 RDI: 0000000000000004
[ 484.086193] RBP: 00007fe36b83d180 R08: 0000000000000000 R09: 0000000000000000
[ 484.086195] R10: 0000000000000001 R11: 0000000000000246 R12: 00007fe36d5783a8
[ 484.086196] R13: 0000557fef023888 R14: 0000557fef02de37 R15: 0000557fef2da500
[ 484.086199] </TASK>

Bisect shows 5fd6bbb [1] is very likely the first bad commit.
Issue reported upstream https://github.com/ColinIanKing/stress-ng/issues/404

[1] https://github.com/ColinIanKing/stress-ng/commit/5fd6bbbf39ea901838f4acc1a4b2057f07851c58

To post a comment you must log in.
This report contains Public information  
Everyone can see this information.

Other bug subscribers

Remote bug watches

Bug watches keep track of this bug in other bug trackers.