https://bugzilla.kernel.org/show_bug.cgi?id=218229 Bug ID: 218229 Summary: xfstests xfs/438 hung Product: File System Version: 2.5 Hardware: Intel OS: Linux Status: NEW Severity: normal Priority: P3 Component: XFS Assignee: filesystem_xfs@xxxxxxxxxxxxxxxxxxxxxx Reporter: dagmcr@xxxxxxxxx Regression: No While doing fstests baseline testing on v6.6-rc5 with kdevops [0] we found a failure rate of ~1/2 for xfs/438 test. [0] https://github.com/linux-kdevops This fails on the following test sections as defined by kdevops [1]: * xfs_crc_logdev * xfs_reflink_logdev [0] https://github.com/linux-kdevops [1] https://github.com/linux-kdevops/kdevops/blob/master/playbooks/roles/fstests/templates/xfs/xfs.config Below is just one full trace. Oct 17 19:10:05 line-xfs-crc-logdev unknown: run fstests xfs/438 at 2023-10-17 19:10:05 Oct 17 19:10:06 line-xfs-crc-logdev kernel: XFS (dm-0): Mounting V5 Filesystem 3e1fc16c-f101-4acb-bacb-39ae396320fe Oct 17 19:10:07 line-xfs-crc-logdev kernel: XFS (dm-0): Ending clean mount Oct 17 19:10:07 line-xfs-crc-logdev kernel: XFS (dm-0): Quotacheck needed: Please wait. Oct 17 19:10:07 line-xfs-crc-logdev kernel: XFS (dm-0): Quotacheck: Done. Oct 17 19:10:07 line-xfs-crc-logdev kernel: XFS (dm-0): Filesystem has been shut down due to log error (0x2). Oct 17 19:10:07 line-xfs-crc-logdev kernel: XFS (dm-0): Please unmount the filesystem and rectify the problem(s). Oct 17 19:10:09 line-xfs-crc-logdev kernel: XFS (dm-0): Unmounting Filesystem 3e1fc16c-f101-4acb-bacb-39ae396320fe Oct 17 19:14:04 line-xfs-crc-logdev kernel: INFO: task umount:17146 blocked for more than 120 seconds. Oct 17 19:14:04 line-xfs-crc-logdev kernel: Not tainted 6.6.0-rc5 #2 Oct 17 19:14:04 line-xfs-crc-logdev kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Oct 17 19:14:04 line-xfs-crc-logdev kernel: task:umount state:D stack:0 pid:17146 ppid:16828 flags:0x00004002 Oct 17 19:14:04 line-xfs-crc-logdev kernel: Call Trace: Oct 17 19:14:04 line-xfs-crc-logdev kernel: <TASK> Oct 17 19:14:04 line-xfs-crc-logdev kernel: __schedule+0x3ab/0xab0 Oct 17 19:14:04 line-xfs-crc-logdev kernel: schedule+0x5d/0xe0 Oct 17 19:14:04 line-xfs-crc-logdev kernel: schedule_timeout+0x143/0x150 Oct 17 19:14:04 line-xfs-crc-logdev kernel: ? __flush_workqueue+0x184/0x400 Oct 17 19:14:04 line-xfs-crc-logdev kernel: __down_common+0xf6/0x200 Oct 17 19:14:04 line-xfs-crc-logdev kernel: ? __pfx_preempt_count_add+0x10/0x10 Oct 17 19:14:04 line-xfs-crc-logdev kernel: ? preempt_count_add+0x6a/0xa0 Oct 17 19:14:04 line-xfs-crc-logdev kernel: down+0x43/0x60 Oct 17 19:14:04 line-xfs-crc-logdev kernel: xfs_log_unmount+0x4a/0xc0 [xfs] Oct 17 19:14:04 line-xfs-crc-logdev kernel: xfs_unmountfs+0x9a/0x1b0 [xfs] Oct 17 19:14:04 line-xfs-crc-logdev kernel: xfs_fs_put_super+0x37/0x80 [xfs] Oct 17 19:14:04 line-xfs-crc-logdev kernel: generic_shutdown_super+0x7c/0x110 Oct 17 19:14:04 line-xfs-crc-logdev kernel: kill_block_super+0x16/0x40 Oct 17 19:14:04 line-xfs-crc-logdev kernel: xfs_kill_sb+0xe/0x20 [xfs] Oct 17 19:14:04 line-xfs-crc-logdev kernel: deactivate_locked_super+0x2f/0xb0 Oct 17 19:14:04 line-xfs-crc-logdev kernel: cleanup_mnt+0xbd/0x150 Oct 17 19:14:04 line-xfs-crc-logdev kernel: task_work_run+0x59/0x90 Oct 17 19:14:04 line-xfs-crc-logdev kernel: exit_to_user_mode_prepare+0x15c/0x160 Oct 17 19:14:04 line-xfs-crc-logdev kernel: syscall_exit_to_user_mode+0x22/0x50 Oct 17 19:14:04 line-xfs-crc-logdev kernel: do_syscall_64+0x46/0x90 Oct 17 19:14:04 line-xfs-crc-logdev kernel: entry_SYSCALL_64_after_hwframe+0x6e/0xd8 Oct 17 19:14:04 line-xfs-crc-logdev kernel: RIP: 0033:0x7fb9538db737 Oct 17 19:14:04 line-xfs-crc-logdev kernel: RSP: 002b:00007fffaf33f768 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6 Oct 17 19:14:04 line-xfs-crc-logdev kernel: RAX: 0000000000000000 RBX: 000055b4718dcb60 RCX: 00007fb9538db737 Oct 17 19:14:04 line-xfs-crc-logdev kernel: RDX: 0000000000000000 RSI: 0000000000000000 RDI: 000055b4718e0820 Oct 17 19:14:04 line-xfs-crc-logdev kernel: RBP: 0000000000000000 R08: 0000000000000007 R09: 000055b4718e0cc0 Oct 17 19:14:04 line-xfs-crc-logdev kernel: R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb953a2623c Oct 17 19:14:04 line-xfs-crc-logdev kernel: R13: 000055b4718e0820 R14: 000055b4718dce70 R15: 000055b4718dca60 Oct 17 19:14:04 line-xfs-crc-logdev kernel: </TASK> Oct 17 19:16:05 line-xfs-crc-logdev kernel: INFO: task umount:17146 blocked for more than 241 seconds. Oct 17 19:16:05 line-xfs-crc-logdev kernel: Not tainted 6.6.0-rc5 #2 Oct 17 19:16:05 line-xfs-crc-logdev kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Oct 17 19:16:05 line-xfs-crc-logdev kernel: task:umount state:D stack:0 pid:17146 ppid:16828 flags:0x00004002 Oct 17 19:16:05 line-xfs-crc-logdev kernel: Call Trace: Oct 17 19:16:05 line-xfs-crc-logdev kernel: <TASK> Oct 17 19:16:05 line-xfs-crc-logdev kernel: __schedule+0x3ab/0xab0 Oct 17 19:16:05 line-xfs-crc-logdev kernel: schedule+0x5d/0xe0 Oct 17 19:16:05 line-xfs-crc-logdev kernel: schedule_timeout+0x143/0x150 Oct 17 19:16:05 line-xfs-crc-logdev kernel: ? __flush_workqueue+0x184/0x400 Oct 17 19:16:05 line-xfs-crc-logdev kernel: __down_common+0xf6/0x200 Oct 17 19:16:05 line-xfs-crc-logdev kernel: ? __pfx_preempt_count_add+0x10/0x10 Oct 17 19:16:05 line-xfs-crc-logdev kernel: ? preempt_count_add+0x6a/0xa0 Oct 17 19:16:05 line-xfs-crc-logdev kernel: down+0x43/0x60 Oct 17 19:16:05 line-xfs-crc-logdev kernel: xfs_log_unmount+0x4a/0xc0 [xfs] Oct 17 19:16:05 line-xfs-crc-logdev kernel: xfs_unmountfs+0x9a/0x1b0 [xfs] Oct 17 19:16:05 line-xfs-crc-logdev kernel: xfs_fs_put_super+0x37/0x80 [xfs] Oct 17 19:16:05 line-xfs-crc-logdev kernel: generic_shutdown_super+0x7c/0x110 Oct 17 19:16:05 line-xfs-crc-logdev kernel: kill_block_super+0x16/0x40 Oct 17 19:16:05 line-xfs-crc-logdev kernel: xfs_kill_sb+0xe/0x20 [xfs] Oct 17 19:16:05 line-xfs-crc-logdev kernel: deactivate_locked_super+0x2f/0xb0 Oct 17 19:16:05 line-xfs-crc-logdev kernel: cleanup_mnt+0xbd/0x150 Oct 17 19:16:05 line-xfs-crc-logdev kernel: task_work_run+0x59/0x90 Oct 17 19:16:05 line-xfs-crc-logdev kernel: exit_to_user_mode_prepare+0x15c/0x160 Oct 17 19:16:05 line-xfs-crc-logdev kernel: syscall_exit_to_user_mode+0x22/0x50 Oct 17 19:16:05 line-xfs-crc-logdev kernel: do_syscall_64+0x46/0x90 Oct 17 19:16:05 line-xfs-crc-logdev kernel: entry_SYSCALL_64_after_hwframe+0x6e/0xd8 Oct 17 19:16:05 line-xfs-crc-logdev kernel: RIP: 0033:0x7fb9538db737 Oct 17 19:16:05 line-xfs-crc-logdev kernel: RSP: 002b:00007fffaf33f768 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6 Oct 17 19:16:05 line-xfs-crc-logdev kernel: RAX: 0000000000000000 RBX: 000055b4718dcb60 RCX: 00007fb9538db737 Oct 17 19:16:05 line-xfs-crc-logdev kernel: RDX: 0000000000000000 RSI: 0000000000000000 RDI: 000055b4718e0820 Oct 17 19:16:05 line-xfs-crc-logdev kernel: RBP: 0000000000000000 R08: 0000000000000007 R09: 000055b4718e0cc0 Oct 17 19:16:05 line-xfs-crc-logdev kernel: R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb953a2623c Oct 17 19:16:05 line-xfs-crc-logdev kernel: R13: 000055b4718e0820 R14: 000055b4718dce70 R15: 000055b4718dca60 Oct 17 19:16:05 line-xfs-crc-logdev kernel: </TASK> Oct 17 19:18:05 line-xfs-crc-logdev kernel: INFO: task umount:17146 blocked for more than 362 seconds. Oct 17 19:18:05 line-xfs-crc-logdev kernel: Not tainted 6.6.0-rc5 #2 Oct 17 19:18:05 line-xfs-crc-logdev kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Oct 17 19:18:05 line-xfs-crc-logdev kernel: task:umount state:D stack:0 pid:17146 ppid:16828 flags:0x00004002 Oct 17 19:18:05 line-xfs-crc-logdev kernel: Call Trace: Oct 17 19:18:05 line-xfs-crc-logdev kernel: <TASK> Oct 17 19:18:05 line-xfs-crc-logdev kernel: __schedule+0x3ab/0xab0 Oct 17 19:18:05 line-xfs-crc-logdev kernel: schedule+0x5d/0xe0 Oct 17 19:18:05 line-xfs-crc-logdev kernel: schedule_timeout+0x143/0x150 Oct 17 19:18:05 line-xfs-crc-logdev kernel: ? __flush_workqueue+0x184/0x400 Oct 17 19:18:05 line-xfs-crc-logdev kernel: __down_common+0xf6/0x200 Oct 17 19:18:05 line-xfs-crc-logdev kernel: ? __pfx_preempt_count_add+0x10/0x10 Oct 17 19:18:05 line-xfs-crc-logdev kernel: ? preempt_count_add+0x6a/0xa0 Oct 17 19:18:05 line-xfs-crc-logdev kernel: down+0x43/0x60 Oct 17 19:18:05 line-xfs-crc-logdev kernel: xfs_log_unmount+0x4a/0xc0 [xfs] Oct 17 19:18:05 line-xfs-crc-logdev kernel: xfs_unmountfs+0x9a/0x1b0 [xfs] Oct 17 19:18:06 line-xfs-crc-logdev kernel: xfs_fs_put_super+0x37/0x80 [xfs] Oct 17 19:18:06 line-xfs-crc-logdev kernel: generic_shutdown_super+0x7c/0x110 Oct 17 19:18:06 line-xfs-crc-logdev kernel: kill_block_super+0x16/0x40 Oct 17 19:18:06 line-xfs-crc-logdev kernel: xfs_kill_sb+0xe/0x20 [xfs] Oct 17 19:18:06 line-xfs-crc-logdev kernel: deactivate_locked_super+0x2f/0xb0 Oct 17 19:18:06 line-xfs-crc-logdev kernel: cleanup_mnt+0xbd/0x150 Oct 17 19:18:06 line-xfs-crc-logdev kernel: task_work_run+0x59/0x90 Oct 17 19:18:06 line-xfs-crc-logdev kernel: exit_to_user_mode_prepare+0x15c/0x160 Oct 17 19:18:06 line-xfs-crc-logdev kernel: syscall_exit_to_user_mode+0x22/0x50 Oct 17 19:18:06 line-xfs-crc-logdev kernel: do_syscall_64+0x46/0x90 Oct 17 19:18:06 line-xfs-crc-logdev kernel: entry_SYSCALL_64_after_hwframe+0x6e/0xd8 Oct 17 19:18:06 line-xfs-crc-logdev kernel: RIP: 0033:0x7fb9538db737 Oct 17 19:18:06 line-xfs-crc-logdev kernel: RSP: 002b:00007fffaf33f768 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6 Oct 17 19:18:06 line-xfs-crc-logdev kernel: RAX: 0000000000000000 RBX: 000055b4718dcb60 RCX: 00007fb9538db737 Oct 17 19:18:06 line-xfs-crc-logdev kernel: RDX: 0000000000000000 RSI: 0000000000000000 RDI: 000055b4718e0820 Oct 17 19:18:06 line-xfs-crc-logdev kernel: RBP: 0000000000000000 R08: 0000000000000007 R09: 000055b4718e0cc0 Oct 17 19:18:06 line-xfs-crc-logdev kernel: R10: 0000000000000000 R11: 0000000000000246 R12: 00007fb953a2623c Oct 17 19:18:06 line-xfs-crc-logdev kernel: R13: 000055b4718e0820 R14: 000055b4718dce70 R15: 000055b4718dca60 Oct 17 19:18:06 line-xfs-crc-logdev kernel: </TASK> Oct 17 19:20:06 line-xfs-crc-logdev kernel: INFO: task umount:17146 blocked for more than 483 seconds. Oct 17 19:20:06 line-xfs-crc-logdev kernel: Not tainted 6.6.0-rc5 #2 Oct 17 19:20:06 line-xfs-crc-logdev kernel: "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message. Oct 17 19:20:06 line-xfs-crc-logdev kernel: task:umount state:D stack:0 pid:17146 ppid:16828 flags:0x00004002 Oct 17 19:20:06 line-xfs-crc-logdev kernel: Call Trace: Oct 17 19:20:06 line-xfs-crc-logdev kernel: <TASK> Oct 17 19:20:06 line-xfs-crc-logdev kernel: __schedule+0x3ab/0xab0 Oct 17 19:20:06 line-xfs-crc-logdev kernel: schedule+0x5d/0xe0 Oct 17 19:20:06 line-xfs-crc-logdev kernel: schedule_timeout+0x143/0x150 Oct 17 19:20:06 line-xfs-crc-logdev kernel: ? __flush_workqueue+0x184/0x400 Oct 17 19:20:06 line-xfs-crc-logdev kernel: __down_common+0xf6/0x200 Oct 17 19:20:06 line-xfs-crc-logdev kernel: ? __pfx_preempt_count_add+0x10/0x10 Oct 17 19:20:06 line-xfs-crc-logdev kernel: ? preempt_count_add+0x6a/0xa0 Oct 17 19:20:06 line-xfs-crc-logdev kernel: down+0x43/0x60 Oct 17 19:20:06 line-xfs-crc-logdev kernel: xfs_log_unmount+0x4a/0xc0 [xfs] Oct 17 19:20:06 line-xfs-crc-logdev kernel: xfs_unmountfs+0x9a/0x1b0 [xfs] Oct 17 19:20:06 line-xfs-crc-logdev kernel: xfs_fs_put_super+0x37/0x80 [xfs] Oct 17 19:20:06 line-xfs-crc-logdev kernel: generic_shutdown_super+0x7c/0x110 Oct 17 19:20:06 line-xfs-crc-logdev kernel: kill_block_super+0x16/0x40 Oct 17 19:20:06 line-xfs-crc-logdev kernel: xfs_kill_sb+0xe/0x20 [xfs] Oct 17 19:20:06 line-xfs-crc-logdev kernel: deactivate_locked_super+0x2f/0xb0 Oct 17 19:20:06 line-xfs-crc-logdev kernel: cleanup_mnt+0xbd/0x150 Oct 17 19:20:06 line-xfs-crc-logdev kernel: task_work_run+0x59/0x90 Oct 17 19:20:06 line-xfs-crc-logdev kernel: exit_to_user_mode_prepare+0x15c/0x160 Oct 17 19:20:06 line-xfs-crc-logdev kernel: syscall_exit_to_user_mode+0x22/0x50 Oct 17 19:20:06 line-xfs-crc-logdev kernel: do_syscall_64+0x46/0x90 Oct 17 19:20:06 line-xfs-crc-logdev kernel: entry_SYSCALL_64_after_hwframe+0x6e/0xd8 Oct 17 19:20:06 line-xfs-crc-logdev kernel: RIP: 0033:0x7fb9538db737 Oct 17 19:20:06 line-xfs-crc-logdev kernel: RSP: 002b:00007fffaf33f768 EFLAGS: 00000246 ORIG_RAX: 00000000000000a6 -- You may reply to this email to add a comment. You are receiving this mail because: You are watching the assignee of the bug.
