vCenterのスケジュールされたファイルベースのバックアップがSFTPターゲットに対して断続的に失敗し、「 BackupManager encountered an exception. See logs for details. 」というエラーが表示されます。
search cancel

vCenterのスケジュールされたファイルベースのバックアップがSFTPターゲットに対して断続的に失敗し、「 BackupManager encountered an exception. See logs for details. 」というエラーが表示されます。

book

Article ID: 416393

calendar_today

Updated On:

Products

VMware vCenter Server

Issue/Introduction

免責事項:これは英文の記事「Scheduled file-based backups for vCenter to an SFTP target sporadically fail with "BackupManager encountered an exception. See logs for details."」の日本語訳です。記事はベストエフォートで翻訳を進めているため、ローカライズ化コンテンツは最新情報ではない可能性があります。最新情報は英語版の記事で参照してください。

vCenterのスケジュールされたファイルベースのバックアップが、エラーメッセージと共に断続的に失敗します:  

BackupManager encountered an exception. See logs for details. https://<vcenter_fqdn>/appliance/support-bundle


同じターゲット/構成を使用した手動トリガーのバックアップは正常に動作しており、スケジュールされたバックアップの多くが同様に正常に動作します。

/var/log/vmware/applmgmt/backup.log を確認すると、Update manager(VUM)コンポーネントのバックアップ中に発生した「Broken pipe」エラーを示す以下のスタックトレースが記録されています:

backup.log
..
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [ComponentScripts::ComponentScriptsBackup:ComponentScripts.py:88] INFO: Execute vum script: /etc/vmware/backup/component-scripts/vum/backup_restore.py --startBackup
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [ComponentScripts::ComponentScriptsBackup:ComponentScripts.py:95] INFO: Dispatching stream.
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [Proc::GetProcsStatus:Proc.py:344] ERROR: Process returncode is -13, but expected exit codes are [0].
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [Proc::GetProcsStatus:Proc.py:328] ERROR: rc: 1, stderr: Traceback (most recent call last):
  File "/usr/lib/applmgmt/backup_restore/py/vmware/appliance/backup_restore/plugins/../util/Calculate.py", line 58, in <module>
    main(sys.argv[1], sys.argv[2], sys.argv[3])
  File "/usr/lib/applmgmt/backup_restore/py/vmware/appliance/backup_restore/plugins/../util/Calculate.py", line 45, in main
    stdout_obj.write(data)
BrokenPipeError: [Errno 32] Broken pipe
..
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [Proc::GetProcsStatus:Proc.py:333] INFO: Skip to report the error.
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [Proc::GetProcsStatus:Proc.py:344] ERROR: Process returncode is 1, but expected exit codes are [0].
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [Proc::UpdateExceptionStatus:Proc.py:384] ERROR: Checksum not generated at /dev/shm/backupRestoreSumFile-<ID>
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [ComponentScripts::ComponentScriptsBackup:ComponentScripts.py:106] ERROR: Component backup command "/etc/vmware/backup/component-scripts/vum/backup_restore.py --startBackup" failed 1.
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [Log::run:Log.py:64] ERROR: Unable to perform backup: [Errno 32] Broken pipe
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [ComponentScriptsBackup:PID-3273501] [ComponentScripts::ComponentScriptsBackup:ComponentScripts.py:135] ERROR: Error during component vum backup
Underlying process status. rc: 1
stdout:
stderr:
Traceback (most recent call last):
  File "/usr/lib/applmgmt/backup_restore/py/vmware/appliance/backup_restore/components/ComponentScripts.py", line 110, in ComponentScriptsBackup
    raise BackupRestoreError(('Error during component %s backup' %
util.Common.BackupRestoreError: Error during component vum backup
Underlying process status. rc: 1
stdout:
stderr:
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [MainProcess:PID-3273234] [Proc::VerifyProcStatusAndGetArchive:Proc.py:159] ERROR: Error at process ComponentScriptsBackup; rc:1.
YYYY-MM-DDThh:mm:ss:uuu [20250112-235904-24322831] [MainProcess:PID-3273234] [Proc::VerifyProcStatusAndGetArchive:Proc.py:163] ERROR: stderr:Error during component vum backup

YYYY-MM-DDThh:mm:ss:uuu[20250112-235904-24322831] [MainProcess:PID-3273234] [Proc::VerifyProcStatusAndGetArchive:Proc.py:172] INFO: Following error message isn't localized:
  stderr:Error during component vum backup

 

Update manager 自体のコンポーネントのバックアップログ(/var/log/vmware/vmware-updatemgr/backup-restore.log)を確認すると、同様に「Broken pipe」のエラーが見つかります:

vmware-updatemgr/backup-restore.log
..
YYYY-MM-DDThh:mm:ss ERROR [3273560] [MainThread] [backup_restore:82] Failed to complete backup.
Traceback (most recent call last):
  File "/etc/vmware/backup/component-scripts/vum/backup_restore.py", line 79, in backup
    tar.add(PATCH_STORE_DIR, filter=skipFile)
  File "/usr/lib/python3.10/tarfile.py", line 2179, in add
    self.add(os.path.join(name, f), os.path.join(arcname, f),
  File "/usr/lib/python3.10/tarfile.py", line 2179, in add
    self.add(os.path.join(name, f), os.path.join(arcname, f),
  File "/usr/lib/python3.10/tarfile.py", line 2179, in add
    self.add(os.path.join(name, f), os.path.join(arcname, f),
  [Previous line repeated 2 more times]
  File "/usr/lib/python3.10/tarfile.py", line 2173, in add
    self.addfile(tarinfo, f)
  File "/usr/lib/python3.10/tarfile.py", line 2201, in addfile
    copyfileobj(fileobj, self.fileobj, tarinfo.size, bufsize=bufsize)
  File "/usr/lib/python3.10/tarfile.py", line 255, in copyfileobj
    dst.write(buf)
  File "/usr/lib/python3.10/tarfile.py", line 441, in write
    self.__write(s)
  File "/usr/lib/python3.10/tarfile.py", line 449, in __write
    self.fileobj.write(self.buf[:self.bufsize])
BrokenPipeError: [Errno 32] Broken pipe

Environment

vCenter Server 7.x

vCenter Server 8.x

Cause

このような問題は通常、競合するバックアップによってバックアップ対象または vCenter と対象間の接続が過負荷状態になることが原因で発生します。これは通常、環境のバックアップウィンドウが密接してスケジュールされていることが原因です。

Resolution

これは vCenter Server 自体の障害ではなく、通常はバックアップ対象側、または vCenter とバックアップ対象間の接続におけるリソース競合が原因です。

こうした散発的なバックアップ問題を防止するには、競合する操作の量を緩和するよう努めてください。具体的には、スケジュールされた vCenter バックアップを別の時間帯に移動させるなどして対応してください。

Additional Information