Не удаётся создать моментальный снимок виртуальной машины после установки агента Acronis Backup Advanced 11.7.50058 для Windows

Thread needs solution
truwrikodrorowrelupicugojestutroclulachosaswunuhospikigawakijosaswenomaruclojeueclikaspedrubewidebrisubrohutrurifruuagothunugekedrumucisiuobrobrecrupeslapuswosluprothethibakaslechurathikucli
Regular Poster
Posts: 122
Comments: 93

После установки агента Acronis Backup Advanced 11.7.50058 для Windows в виртуальной системе на базе Windows Server 2012 R2 при попытке резервного копирования (создания моментального снимка в ESXi 6.0 с опцией quiesce) выдаётся ошибка:

The guest OS has reported an error during quiescing. The error code was: 5 The error message was: 'VssSyncStart' operation failed: IDispatch error #8449 (0x80042301) 

Дальнейший анализ показал, что проблема кроется в работе Службы криптографии (CryptSvc), т.к. выполнение vssadmin list writers выдало следующее сообщение:

Имя компонента записи: "System Writer"
   Id компонента записи: {e8132975-6f93-4464-a53e-1050253ae220}
   Id экземпляра компонента записи: {71052417-f893-41e0-bc90-4cc5b5185569}
   Состояние: [8] Неисправен
   Последняя ошибка: Несогласованная теневая копия

Удаление (переустановка) агента Acronis Backup Advanced 11.7.50058 для Windows и переустановка VMware Tools не решили проблему.

Отключение Службы криптографии решает проблему, но это не правильное решение как и резервное копирование без использования теневого копирования.

Для поиска решения проблемы были выполнены инструкции согласно статье: https://kb.acronis.com/content/45472

При любых комбинациях с использованием diskshadow теневое копирование всегда завершается успешно.

Небольшая часть лога с ошибкой 0x80042301, полученного при помощи утилиты vsstrace в момент снапшота:

[WRTWRTIC(3124)   WRITER] CONTEXT[CVssWriterImpl::FreezeInternal] Adding context: ' Freeze' (0)
[WRTWRTIC(3125)   WRITER] CONTEXT[CVssWriterImpl::FreezeInternal] Adding context: ' ' = 'Writer' (2)
[WRTWRTIC(3126)   WRITER] CONTEXT[CVssWriterImpl::FreezeInternal] Adding context: '   ' = '{e8132975-6f93-4464-a53e-1050253ae220}' (2)
[WRTWRTIC(3127)   WRITER] CONTEXT[CVssWriterImpl::FreezeInternal] Adding context: '  ' = 'System Writer' (2)
[WRTWRTIC(3130)   WRITER] CONTEXT[CVssWriterImpl::FreezeInternal] Adding context: '   ' = '{84cbb209-5e9c-477e-8486-98dce8cfbae4}' (2)
[WRTWRTIC(3132)   WRITER] Received Event: Freeze
[WRTWRTIC(3133)   WRITER] SnapshotSetID         = {2B421680-3D52-4551-AFF8-1A7ACB39A4DD}
[WRTWRTIC(3134)   WRITER] Level                 = 1
[WRTWRTIC(3135)   WRITER] WriterId              = {e8132975-6f93-4464-a53e-1050253ae220}
[WRTWRTIC(3136)   WRITER] WriterName            = System Writer
[WRTWRTIC(3137)   WRITER] wszWriterInstanceName = (NULL)
[WRTWRTIC(3138)   WRITER] InstanceId for Writer System Writer is{84cbb209-5e9c-477e-8486-98dce8cfbae4}
[WRTWRTIC(5938)   WRITER] ENTER[CVssWriterState::UpdateThreadIdForSession] 
[WRTWRTIC(5938)   WRITER] EXIT[CVssWriterState::UpdateThreadIdForSession] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(1327)      GEN] ENTER[CVssDiag::RecordGenericEvent] 
[REGREGSC(1331)      GEN] Parameters 1003, 1, 8, 0x800423f0, {2b421680-3d52-4551-aff8-1a7acb39a4dd}
[REGREGSC(1350)      GEN] Event name: FREEZE (Enter)
[REGREGSC(1401)      GEN] ENTER[CVssDiag::FlushQueue] 
[REGREGSC(1401)      GEN] EXIT[CVssDiag::FlushQueue] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(0364)      GEN] ENTER[CVssRegistryKey::SetBinaryValue] 
[REGREGSC(0364)      GEN] EXIT[CVssRegistryKey::SetBinaryValue] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(1327)      GEN] EXIT[CVssDiag::RecordGenericEvent] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[WRTWRTIC(1829)   WRITER] ENTER[CVssWriterImpl::EnterState] 
[INCWRMPH(0899)   WRITER] ENTER[CVssWriterImpl::Lock] 
[INCWRMPH(0899)   WRITER] EXIT[CVssWriterImpl::Lock] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[WRTWRTIC(1851)   WRITER] Writer state is not a beginning state at the start of snapshot sequence. Previous sequence must have been interupted
[WRTWRTIC(1829)   WRITER] EXIT[CVssWriterImpl::EnterState] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(1327)      GEN] ENTER[CVssDiag::RecordGenericEvent] 
[REGREGSC(1331)      GEN] Parameters -2147212301, 1, 8, 0x800423f0, {2b421680-3d52-4551-aff8-1a7acb39a4dd}
[REGREGSC(1350)      GEN] Event name: ((HRESULT)0x800423F3L) (SetCurrentFailure)
[REGREGSC(1401)      GEN] ENTER[CVssDiag::FlushQueue] 
[REGREGSC(1401)      GEN] EXIT[CVssDiag::FlushQueue] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(0364)      GEN] ENTER[CVssRegistryKey::SetBinaryValue] 
[REGREGSC(0364)      GEN] EXIT[CVssRegistryKey::SetBinaryValue] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(1327)      GEN] EXIT[CVssDiag::RecordGenericEvent] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(1327)      GEN] ENTER[CVssDiag::RecordGenericEvent] 
[REGREGSC(1331)      GEN] Parameters -2147212301, 10, 8, 0x800423f0, {2b421680-3d52-4551-aff8-1a7acb39a4dd}
[REGREGSC(1327)      GEN] EXIT[CVssDiag::RecordGenericEvent] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[WRTWRTIC(3153)   WRITER] THROW[CVssWriterImpl::FreezeInternal] Improper entry into state
[INCSTRH(0697)      GEN] ENTER[CVssAutoCoString::Append] 
[INCSTRH(0689)      GEN] ENTER[CVssAutoCoString::Reallocate] 
[INCSTRH(0689)      GEN] EXIT[CVssAutoCoString::Reallocate] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] EXIT[CVssAutoCoString::Append] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] ENTER[CVssAutoCoString::Append] 
[INCSTRH(0689)      GEN] ENTER[CVssAutoCoString::Reallocate] 
[INCSTRH(0689)      GEN] EXIT[CVssAutoCoString::Reallocate] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] EXIT[CVssAutoCoString::Append] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] ENTER[CVssAutoCoString::Append] 
[INCSTRH(0689)      GEN] ENTER[CVssAutoCoString::Reallocate] 
[INCSTRH(0689)      GEN] EXIT[CVssAutoCoString::Reallocate] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] EXIT[CVssAutoCoString::Append] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] ENTER[CVssAutoCoString::Append] 
[INCSTRH(0689)      GEN] ENTER[CVssAutoCoString::Reallocate] 
[INCSTRH(0689)      GEN] EXIT[CVssAutoCoString::Reallocate] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] EXIT[CVssAutoCoString::Append] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] ENTER[CVssAutoCoString::Append] 
[INCSTRH(0689)      GEN] ENTER[CVssAutoCoString::Reallocate] 
[INCSTRH(0689)      GEN] EXIT[CVssAutoCoString::Reallocate] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] EXIT[CVssAutoCoString::Append] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] ENTER[CVssAutoCoString::Append] 
[INCSTRH(0689)      GEN] ENTER[CVssAutoCoString::Reallocate] 
[INCSTRH(0689)      GEN] EXIT[CVssAutoCoString::Reallocate] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[INCSTRH(0697)      GEN] EXIT[CVssAutoCoString::Append] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(1327)      GEN] ENTER[CVssDiag::RecordGenericEvent] 
[REGREGSC(1331)      GEN] Parameters 1003, 0, 8, 0x800423f0, {2b421680-3d52-4551-aff8-1a7acb39a4dd}
[REGREGSC(1350)      GEN] Event name: FREEZE (Leave)
[REGREGSC(1401)      GEN] ENTER[CVssDiag::FlushQueue] 
[REGREGSC(1401)      GEN] EXIT[CVssDiag::FlushQueue] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(0364)      GEN] ENTER[CVssRegistryKey::SetBinaryValue] 
[REGREGSC(0364)      GEN] EXIT[CVssRegistryKey::SetBinaryValue] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[REGREGSC(1327)      GEN] EXIT[CVssDiag::RecordGenericEvent] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[WRTWRTIC(5938)   WRITER] ENTER[CVssWriterState::UpdateThreadIdForSession] 
[WRTWRTIC(5938)   WRITER] EXIT[CVssWriterState::UpdateThreadIdForSession] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[WRTWRTIC(3235)   WRITER] HRESULT exception caught: hr: 0x80042301
[WRTWRTIC(2111)   WRITER] ENTER[CVssWriterImpl::LeaveState] 
[INCWRMPH(0910)   WRITER] ENTER[CVssWriterImpl::Unlock] 
[INCWRMPH(0910)   WRITER] EXIT[CVssWriterImpl::Unlock] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[WRTWRTIC(2111)   WRITER] EXIT[CVssWriterImpl::LeaveState] Time spent: 00:00:00-0000; total: 0; HRESULT: 0
[WRTWRTIC(3104)   WRITER] EXIT[CVssWriterImpl::FreezeInternal] Time spent: 00:00:00-0000; total: 0; HRESULT: 0x80042301

Как устранить описанную ошибку?

Sun, 04/23/2017 - 18:02
0 Users found this helpful
truwrikodrorowrelupicugojestutroclulachosaswunuhospikigawakijosaswenomaruclojeueclikaspedrubewidebrisubrohutrurifruuagothunugekedrumucisiuobrobrecrupeslapuswosluprothethibakaslechurathikucli
Regular Poster
Posts: 122
Comments: 93

Мне удалось разобраться с проблемой. Возможно кому-то пригодится эта информация, потому что причина возникномения ошибки нетипичная, и при отсутствии опыта можно потратить немало времени.

Сразу отмечу, что причина проблемы кроется не в агенте Acronis Backup Advanced 11.7 для Windows.

В моём случае в один прекрасный момент, когда за раз много чего было установлено и настроено в виртуальной системе на базе Windows Server 2012 R2, при попытке её резервного копирования при помощи Acronis Backup Advanced 11.7 (создания моментального снимка в ESXi 6.0 с опцией quiesce) начала выдаваться ошибка:

The guest OS has reported an error during quiescing. The error code was: 5 The error message was: 'VssSyncStart' operation failed: IDispatch error #8449 (0x80042301)

Для выяснения причины ошибки помогла утилита vsstrace, входящая в состав SDK для Windows 7, которую необходимо запустить перед резервным копированием для сбора информации о процессе теневого копирования:

vsstrace.exe -l 140 +f 0xffff -o c:\trace.log

Анализ лога vsstrace показал, что перед появлением ошибки 0x80042301 в логах фигурирует информация о том, что не удаётся выполнить какие-то действия в отношении одной из папок. В этой папке ничего примечательного не было: из неё запускался один процесс в качестве системной службы, а также она находилась на диске, присоединённом в режиме физической совместимости. Если же выполнить команду diskshadow list writers, то можно было увидеть, что эта папка каким-то образом участвует в теневом копировании, за которое ответчает "System Writer" - служба криптографии (CryptSvc). Получается, что создание гипервизором моментальных снимков виртуальной машины не выполняет внутри системы теневое копирование дисков, присоединённых в режиме физической совместимости, из-за чего и возникает ошибка.

Таким образом, чтобы избежать проблемы с невозможностью резервного копирования с использованием моментальных снимков из-за ошибки 0x80042301, необходимо убедиться, что те данные, которые подподают под теневое копирование, находятся на дисках, для которых возможно создание моментальных снимков средствами гипервизора.

Tue, 04/25/2017 - 14:32