Im Einsatz befinden sich
OPSI 4.2
opsi-client-agent 4.2.0.20-2
opsi-script 4.12.4.36-1
windows10-upgrade 21h2-1
zielsystem: 1909 & 20h2
quelldateien: 21h2
wir testen gerade das Upgrade auf 21H2 und das Ergebnis ist durchwachsen.
Die Testrechner werden jeweils vor der Upgrade-Installation frisch für diesen Test aufgesetzt.
Die Windows-Installation läuft immer durch, wie durch OPSI im Logfile bestätigt auch erfolgreich,
trotz debug=true & quiet=false.
Aber nach einem Neustart stellt OPSI nach ca. 1/3 der Upgrade Installationen fest,
das die Installation tatsächlich fehlgeschlagen ist, und noch die alte Windows-Version installiert ist.
Windows zeigt nach der Anmeldung dann immer diese Fehlermeldung:
Nachdem eine erste Googlesuche nichts verwertbares brachte, habe ich das ganze Wochenende rauf und runter getestet,
mit allen möglichen Upgrade Szenarien experiementiert (1909->21H2, 20H2->21H2, Rechner verschlüsselt/unverschlüsselt,
diverse Versionen der Verschlüsselungssoftware, UEFI/Legacy BIOS) und es gibt tatsächlich kein Muster, der Fehler tritt
scheinbar willkürlich/zufällig auf. Nach einem Fehler habe ich den selben Rechner nach exakt dem gleichen Schema
wieder aufgesetzt und der Fehler trat nicht auf.
Dann habe ich mir eben von einem der Rechner die Logdateien nochmal genauer angesehen und dank einem Hinweis im Netz
doch etwas gefunden; Ausschnitt aus der setupact.log, Interessant vor allem die letzte Zeile:
Code: Alles auswählen
2022-02-13 01:13:08, Info MIG Mig::CPlatform::CreateProfileForUser: Called for user WIN10TEST\Administrator with ProfileSuffix: Administrator, ProfilePath: (NULL)
2022-02-13 01:13:08, Info MIG Creating profile for user S-1-5-21-4099530483-4260887200-2403809100-500, WIN10TEST\Administrator (Administrator, (NULL)). Using existent SID
2022-02-13 01:13:09, Info MIG Mig::CPlatform::CreateProfileForUser: ACL for profile C:\Users\Administrator: O:SYG:SYD:P(A;OICI;FA;;;SY)(A;OICI;FA;;;BA)(A;OICI;FA;;;LA)
2022-02-13 01:13:09, Info MIG Adding indirect mapping for HKCU (C:\Users\Administrator\NTUSER.DAT) to 0x80000003, S-1-5-21-4099530483-4260887200-2403809100-500
2022-02-13 01:13:09, Info [0x0803e2] MIG Adding indirect mapping from HKCU to <C:\Users\Administrator\NTUSER.DAT> loaded at HKEY_USERS\S-1-5-21-4099530483-4260887200-2403809100-500 (R/W)
2022-02-13 01:13:09, Info [0x0803e4] MIG Successfully mapped HKCU
2022-02-13 01:13:09, Info [0x0803e6] MIG Removing mapping for HKCU
2022-02-13 01:13:09, Info [0x0803e7] MIG Successfully unmapped HKCU
2022-02-13 01:13:09, Info SP Processing known folders for user WIN10TEST\Administrator (S-1-5-21-4099530483-4260887200-2403809100-500)
2022-02-13 01:13:09, Info SP Shell folder CSIDL_INTERNET_CACHE: proposed path is the same with default path: C:\Users\Administrator\AppData\Local\Microsoft\Windows\INetCache
2022-02-13 01:13:09, Info SP Shell folder CSIDL_COOKIES: proposed path is the same with default path: C:\Users\Administrator\AppData\Local\Microsoft\Windows\INetCookies
2022-02-13 01:13:09, Info SP Adding mapping from S-1-5-21-4099530483-4260887200-2403809100-500 to S-1-5-21-4099530483-4260887200-2403809100-500
2022-02-13 01:13:09, Info [0x0803b2] MIG Adding user S-1-5-21-4099530483-4260887200-2403809100-1003, WIN10TEST\opsisetupuser
2022-02-13 01:13:09, Info [0x0803b3] MIG User S-1-5-21-4099530483-4260887200-2403809100-1003, WIN10TEST\opsisetupuser added successfully
2022-02-13 01:13:09, Info SP Attempting to create a regular user profile in C:\Users\opsisetupuser (suffix: opsisetupuser)
2022-02-13 01:13:09, Info MIG COutOfProcPluginFactory::FreeSurrogateHost: Shutdown in progress.
2022-02-13 01:13:09, Info MIG MigHost: Exiting process.
2022-02-13 01:13:09, Info MIG COutOfProcPluginFactory::LaunchSurrogateHost::CommandLine: "C:\$WINDOWS.~BT\Sources\mighost.exe" {B857FAA5-34AF-4EB0-867B-BA059FEAF2B4} /InitDoneEvent:MigHost.{B857FAA5-34AF-4EB0-867B-BA059FEAF2B4}.Event /ParentPID:5472 /LogDir:"C:\Windows\Panther"
2022-02-13 01:13:09, Info MIG MigHost started with command line: {B857FAA5-34AF-4EB0-867B-BA059FEAF2B4} /InitDoneEvent:MigHost.{B857FAA5-34AF-4EB0-867B-BA059FEAF2B4}.Event /ParentPID:5472 /LogDir:"C:\Windows\Panther"
2022-02-13 01:13:09, Info MIG MigHost: CMigPluginSurrogate::Init: Successfully initialized surrogate.
2022-02-13 01:13:09, Info MIG MigHost: Initialized successfully with CLSID[{B857FAA5-34AF-4EB0-867B-BA059FEAF2B4}] and LogDir=[C:\Windows\Panther]
2022-02-13 01:13:09, Info MIG COutOfProcPluginFactory::LaunchSurrogateHost: Successfully launched host and got control object.
2022-02-13 01:13:09, Info [0x080489] MIG Setting system object filter context (System)
2022-02-13 01:13:09, Info [0x0803e5] MIG Not unmapping HKCU\Software\Classes; it is not mapped
2022-02-13 01:13:09, Info [0x0803e5] MIG Not unmapping HKCU; it is not mapped
2022-02-13 01:13:09, Info [0x080411] MIG Setting SMI registry mappings for system context
2022-02-13 01:13:09, Info [0x080489] MIG Setting system object filter context (System)
2022-02-13 01:13:09, Info MIG Mig::CPlatform::CreateProfileForUser: Called for user WIN10TEST\opsisetupuser with ProfileSuffix: opsisetupuser, ProfilePath: (NULL)
2022-02-13 01:13:09, Info MIG Creating profile for user S-1-5-21-4099530483-4260887200-2403809100-1003, WIN10TEST\opsisetupuser (opsisetupuser, (NULL)). Using existent SID
2022-02-13 01:13:09, Info MIG Mig::CPlatform::CreateProfileForUser: ACL for profile C:\Users\opsisetupuser.000: O:SYG:SYD:P(A;OICI;FA;;;SY)(A;OICI;FA;;;BA)(A;OICI;FA;;;S-1-5-21-4099530483-4260887200-2403809100-1003)
2022-02-13 01:13:09, Info MIG Adding indirect mapping for HKCU (C:\Users\opsisetupuser.000\NTUSER.DAT) to 0x80000003, S-1-5-21-4099530483-4260887200-2403809100-1003
2022-02-13 01:13:09, Info [0x0803e2] MIG Adding indirect mapping from HKCU to <C:\Users\opsisetupuser.000\NTUSER.DAT> loaded at HKEY_USERS\S-1-5-21-4099530483-4260887200-2403809100-1003 (R/W)
2022-02-13 01:13:09, Info [0x0803e4] MIG Successfully mapped HKCU
2022-02-13 01:13:09, Info [0x0803e6] MIG Removing mapping for HKCU
2022-02-13 01:13:09, Info [0x0803e7] MIG Successfully unmapped HKCU
2022-02-13 01:13:09, Warning SP User profile suffix mismatch: upgrade asked for "opsisetupuser", actual suffix is: "opsisetupuser.000"
Code: Alles auswählen
2022-02-13 01:13:09, Error SP pSPExecuteApply: Migration phase caught exception: Win32Exception: User profile suffix mismatch, upgrade cannot continue: Das angegebene Profil ist nicht f�r den Typ des angegebenen Ger�ts vorgesehen. [0x000007E7] enum MIGSTATUS __cdecl pSPExecuteApply(enum SetupPlatform::SP_MIG_SCOPE,class UnBCL::String *,int,int,int,class UnBCL::ArrayList<class UnBCL::String *> *,class UnBCL::String *,class UnBCL::String *,class UnBCL::ArrayList<class UnBCL::DictionaryEntry<class UnBCL::String *,class UnBCL::String *> *> *,class UnBCL::String *,int,int,class UnBCL::String *,class UnBCL::String *,class UnBCL::String *,class UnBCL::String *,class UnBCL::String *,class UnBCL::String *,class UnBCL::ArrayList<class CWIMBootData *> *,class UnBCL::String *,int *,class CSPTelemetryData *,struct ISPMigProgress *,long *)
2022-02-13 01:13:09, Info SP SPExecuteFirstBootApply: End run. Result: 0x00000004
2022-02-13 01:13:09, Error SP Apply (first boot apply, online phase): Migration phase failed. Result: 4, specific error: 0x800707E7[gle=0x00000002]
2022-02-13 01:13:09, Info SP SetupPlatform: Global progress: 71, Phase progress: 93
2022-02-13 01:13:09, Info SP SETUPPLATFORMEXE: Sending progress message: Phase: First Boot, Operation: Migrate data, Percentage: 93%
2022-02-13 01:13:09, Info SP SETUPPLATFORMCOMM: Progress message received: Phase: First Boot, Operation: Migrate data, Percentage: 93%
2022-02-13 01:13:09, Error SP Operation failed: First boot apply. Error: 0x800707E7[gle=0x000000b7]
2022-02-13 01:13:09, Error SP Operation execution failed: 13. hr = 0x800707E7
2022-02-13 01:13:09, Error SP ExecuteOperations: Failed execution phase Post First Boot. Error: 0x800707E7
2022-02-13 01:13:09, Error SP Operation execution failed.
2022-02-13 01:13:09, Error SP CSetupPlatformPrivate::Execute: Failed to deserialize/execute post-FirstBoot operations. Error: 0x800707E7
2022-02-13 01:13:09, Info Persisting diagnostics data to C:\$WINDOWS.~BT\Sources\Diagnostics\diagnostics.dat
2022-02-13 01:13:09, Info Diagnostics data saved successfully
2022-02-13 01:13:09, Info SP Execution phase [Post SysPrep] exiting with HRESULT [0x800707E7]
2022-02-13 01:13:09, Info SP SETUPPLATFORMCOMM: Progress message received: Phase: First Boot, Operation: Migrate data, Percentage: 93%
2022-02-13 01:13:09, Info SP WINDEPLOY error code is 0x80071501. Will not attempt uninstall
Und was hantiert der da vorher mit dem lokalen Administator? Der ist bei uns deaktiviert.
Ich versuche gerade den Fehler zu reproduzieren, um die OPSI Logdateien hier hochzuladen, die wurden leider nicht gesichert und zwischenzeitlich überschrieben. Die Windows Upgrade Logdateien sind leider zu groß um sie komplett hier hochzuladen.