[Bug 218229] xfstests xfs/438 hung

[Date Prev][Date Next][Thread Prev][Thread Next][Date Index][Thread Index]

 



https://bugzilla.kernel.org/show_bug.cgi?id=218229

--- Comment #1 from chandanbabu@xxxxxxxxxx ---
On Tue, Dec 05, 2023 at 12:26:54 PM +0000, bugzilla-daemon@xxxxxxxxxx wrote:
> 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

This bug was fixed by
https://lore.kernel.org/linux-xfs/20231030203349.663275-1-leah.rumancik@xxxxxxxxx/

-- 
You may reply to this email to add a comment.

You are receiving this mail because:
You are watching the assignee of the bug.




[Index of Archives]     [XFS Filesystem Development (older mail)]     [Linux Filesystem Development]     [Linux Audio Users]     [Yosemite Trails]     [Linux Kernel]     [Linux RAID]     [Linux SCSI]


  Powered by Linux