The best way to troubleshoot Group Policy processing is to break the process down into three phases. Within each phase of the process is a subset of processing scenarios. When processing Group Policy, the Group Policy service iterates through each scenario as it transitions to each phase. The phases of Group Policy processing are:
This section provides information about each phase of Group Policy processing and the processing scenarios included in each phase.
An instance of Group Policy processing starts with the pre-processing phase. This introductory phase is where the Group Policy service collects the required information to process Group Policy. The service collects this data using processing scenarios, which are small subsets of policy processing within a given phase of policy processing. The processing scenarios included in the preprocessing phase are:
Scenario: Start policy processing
Windows Vista creates an instance of Group Policy processing during startup, user logon, periodic and manual refreshes, and changes to network interfaces. Each instance of Group Policy begins with a Group Policy processing start event. This is an informational event with an event id ranging from 4000–4007. The following table lists the different types of Group Policy processing start events.
|
Event ID
|
Start event type
|
|---|
4000 | Computer startup |
4001 | User logon |
4002 | Computer network change |
4003 | User network change |
4004 | Computer manual refresh |
4005 | User manual refresh |
4006 | Computer periodic refresh |
4007 | User periodic refresh |
The Group Policy service records an event between 4000–4007 in the Group Policy operational log when an instance of Group Policy begins. Also included in the event is the ActivityID that identifies the instance of Group Policy processing. The following are examples of the start policy processing scenario.
12:41:16.472 4000 Starting computer boot policy processing for CONTOSO\MSTEPVISTA$.
ActivityID: {89824640-B13A-4C67-B2EE-9DEB948182F9}
14:15:55.708 4001 Starting user logon Policy processing for CONTOSO\user.
ActivityID: {6A64962C-6C32-4C8A-8E89-C53FB71A7A67}
Scenario: Retrieve account information
The Group Policy service must retrieve the location of the user or computer object in Active Directory before it can apply Group Policy. The GPO discovery scenario uses this information to determine which Group Policy objects are within scope for the given user or computer. The retrieve account information scenario includes the following events:
Event ID 5320: Informational/successful interaction event
The Group Policy service writes this event to record information about an imminent interaction with a dependent component or a successful interaction with a dependent component. It is normal for this event to appear multiple times in the operational log. One of three different events may follow when the Group Policy service uses this event to describe an imminent interaction:
|
Event ID
|
Explanation
|
|---|
5320 | Success interaction event: The interaction described in the event completed successfully. |
6320 | Warning interaction event: The interaction described in the event completed with one or more errors. |
7320 | Error interaction event: The interaction described in the event failed to complete. |
The following example shows the event 5320 used as an informational event in the retrieve account information scenario.
12:41:16.632 5320 Attempting to retrieve the account information.
Event ID 4017: Start-trace component event
The Group Policy service records this event before making a system call. Often, the Group Policy service must use another function of Windows to gather information required to process Group Policy. When a component of Windows asks another component of Windows to perform some specific work and return the information, it is referred to as a system call. The Group Policy service performs system calls throughout an instance of Group Policy processing. Therefore, it is normal for these events to appear multiple times in the operational log.
Event ID 4017, sometimes called the "trace" event, represents the beginning of a system call. Each 4017 event must have a corresponding end event. The Group Policy service records one of the following end-trace events.
|
Event ID
|
Explanation
|
|---|
5017 | Success end-trace event: The system call described in the event completed successfully. |
6017 | Warning end-trace event: The system call described in the event completed with one or more errors. |
7017 | Error end-trace event: The system call described in the event failed to complete. |
All end-trace events contain the elapsed time used by the system call. Warning and failed end-trace events contain error information in the Details tab. The following is an example of a start-trace event and successful end-trace event, both of which occur during the retrieve account information scenario.
2006-09-14 12:41:16.632 4017 Making system call to get account information.
2006-09-14 12:41:17.022 5017 The system call to get account information completed.
CN=MSTEPVISTA,CN=Computers,DC=contoso,DC=com The call completed in 390 milliseconds.
Note |
|---|
|
Most ending events regardless of success, warning, or error display the amount of elapsed time, in milliseconds, from the start event. For example, end events for policy processing (event IDs 8000–8007) display how long it took the Group Policy service to process Group Policy. Trace events (events ending in 017) display elapsed time used to perform the system call. You can use these values to determine if Group Policy processing is delaying computer startup or user logon. |
Scenario: Domain controller discovery
The Group Policy service reads Group Policy objects from Active Directory. Therefore, the service must discover a domain controller.
Event ID 4326: Domain controller discovery start event
This event marks the beginning of the domain controller (DC) discovery scenario and follows with event ID 5320, which is used to record information about the Group Policy service interacting with other portions of the operating system.
12:41:17.022 4326 Group Policy is trying to discover the Domain Controller information.
12:41:17.022 5320 Retrieving Domain Controller details.
The DC discovery process continues by recording a start-trace event, which includes the name of the discovered domain controller the Group Policy service uses to retrieve domain controller information, and corresponding end-trace event.
|
Event ID
|
Explanation
|
|---|
5017 | Success end-trace event: The system call described in the event completed successfully |
6017 | Warning end-trace event: The system call described in the event completed with one or more errors. |
7017 | Error end-trace event: The system call described in the event failed to complete. |
12:41:19.376 5017 The LDAP call to connect and bind to Active Directory completed. hq-con-srv-01.contoso.com The call completed after 171 milliseconds.
Next, the Group Policy service records the DC discovery end event.
Event ID 5308: DC discovery interaction event
The Group Policy service records the DC discovery interaction event to report the result of a specific interaction that occurred during the DC discovery scenario. Interaction events report the results of the interaction with a success, warning, or failure event. Also, each event includes additional information related to the reported result.
|
Event
|
Explanation
|
|---|
5308 | Success DC interaction event: The interaction described in the paragraph before this table has completed successfully. |
6308 | Warning DC interaction event: The interaction described in the paragraph before this table has completed with one or more errors. |
7308 | Error DC interaction event: The interaction described in the paragraph before this table did not complete. |
A successful DC interaction event contains information returned from the domain controller. This information includes the universal naming convention (UNC) path and IP address of the contacted domain controller. Warning and failure interaction events contain the return error code in the description. You can view a description of the error on the Details tab.
Note |
|---|
|
It is common to see a start-trace event and end trace event before a DC discovery interaction event. Also, the end-trace event and the DC discovery interaction event usually start with the same number. For example, the first digit in a successful end-trace event is the number five; therefore, the first digit of the DC discovery interaction event is also a five. The following is an example of a successful DC discovery interaction event, which occurs during the Domain controller discovery scenario. |
12:41:19.376 5308 Domain Controller details:
Domain Controller Name: \\hq-con-srv-01.contoso.com Domain Controller IP Address : \\192.168.0.1
Event ID 5326: sDomain controller discovery end event
Domain controller discovery completes when the Group Policy service records the DC discovery end event. This event reports the result of the Group Policy service's attempt to discover a domain controller. And, just like most of the other events, the DC discovery event has three statuses: success, warning, and error.
|
Event ID
|
Explanation
|
|---|
5326 | Success DC discovery end event: The process of discovering a domain controller completed successfully. |
6326 | Warning DC discovery end event: The process of discovering a domain controller completed with one or more errors. |
7326 | Error DC discovery end event: The process of discovering a domain controller did not complete. |
All of these event IDs report the lapsed time used to discover a domain controller. The following is a example of a complete DC discovery scenario.
12:41:17.022 4326 Group Policy is trying to discover the Domain Controller information.
12:41:17.022 5320 Retrieving Domain Controller details.
12:41:19.206 4017 Making LDAP calls to connect and bind to Active Directory. hq-con-srv-01.contoso.com
12:41:19.376 5017 The LDAP call to connect and bind to Active Directory completed. hq-con-srv-01.contoso.com The call completed after 171 milliseconds.
12:41:19.376 5308 Domain Controller details:
Domain Controller Name : \\hq-con-srv-01.contoso.com Domain Controller IP Address : \\192.168.0.1
12:41:19.376 5326 Group Policy successfully discovered the Domain Controller in 2354 milliseconds.
Scenario: Computer role discovery
In this scenario, the Group Policy service detects the role of the computer. The computer role determines if the current computer is a standalone workstation or server; domain member computer, which supports directory services; domain controller; or domain member computer, which does not support directory services. The Group Policy service requires this information to apply Group Policy based on the computer's role.
Event ID 5309: Computer information event
The Group Policy service records this interaction event after an attempt to determine the role of the current computer.
|
Event ID
|
Explanation
|
|---|
5309 | Success computer information event: The discovery of computer information completed successfully. |
6309 | Warning computer information event: The discovery of computer information completed with one or more errors. |
7309 | Error computer information event: The discovery of computer information did not complete. |
Completed computer information events provide the role of the computer and the name of the network. The event displays the computer role as a numerical value. You can use the following table to determine the role of the computer.
|
Value
|
Explanation
|
|---|
0 | The current computer is not a member of a domain and is a standalone workstation or server. |
1 | The current computer is a member of a domain that does not support directory services. |
2 | The current computer is a member of a domain that supports directory services. |
3 | The current computer is a domain controller. |
The following is example output of the computer role discovery scenario.
12:41:19.416 5309 Computer details: Computer role : 2 Network name :
Scenario: Security principal discovery
The Group Policy service applies Group Policy to computers and users. These are two examples of security principals (computers and users)—an entity recognized by the Windows security system. The Group Policy service must discover if the current security principal is a user or computer in order to apply the correct policy settings.
Event ID 5310: Security principal information event
The Group Policy service records this interaction event after its attempt to retrieve information about the current security principal, which is a computer or user.
|
Event ID
|
Explanation
|
|---|
5310 | Success security principal information event: Discovering information about the current security principal completed successfully. |
6310 | Warning security principal information event: Discovering information about the current security principal completed with one or more errors. |
7310 | Error security principal information event: Discovering information about the current security principal did not complete. |
The success and warning versions of the security principal information event contain information about the security principal, such as:
-
Distinguished name of the account.
-
Name of the domain where the account is located.
-
Name of the domain controller used to determine the account information.
-
Name of the domain where the domain controller resides.
The following is example output of the security principal discovery scenario
12:41:19.416 5310 Account details: Account Name:CN=MSTEPVISTA,CN=Computers,DC=contoso,DC=com
Account Domain Name : contoso.com
DC Name : \\hq-con-srv-01.contoso.com
DC Domain Name : contoso.com
Scenario: Loopback processing mode discovery
Group Policy loopback processing changes how the Group Policy service applies user policies. Typically, the Group Policy service reads Group Policy objects within the scope of the user object to determine user policy setting. Depending on the mode, loopback processing merges or replaces the user policy settings with user policy settings included in Group Policy objects within the scope of the computer object.
Event ID 5311: Loopback processing mode event
The Group Policy service records this interaction event after it has determined the loopback processing mode.
|
Event ID
|
Explanation
|
|---|
5311 | Success loopback processing mode event: Determining the loopback processing mode completed. |
6311 | Warning loopback processing mode event: Determining the loopback processing mode completed with one or more errors. |
7311 | Error loopback processing mode event: Determining the loopback processing mode did not complete. |
The event description includes quoted text that identifies the loopback processing mode.
-
No loopback mode: Loopback processing is not enabled.
-
Merge: Loopback processing is enabled. The Group Policy service merges user settings within the scope of the computer with user setting within the scope of the user.
-
Replace: Loopback processing is enabled. The Group Policy service replaces user settings within the scope of the user with user settings from the scope of the computer.
The following is example output of the loopback processing mode discovery scenario.
12:41:19.486 5311 The loopback policy processing mode is "No loopback mode".
Scenario: GPO discovery
The Group Policy service discovers a list of Group Policy objects applicable to the computer or user. When the service has the list, it checks the accessibility of each Group Policy object by reading the gpt.ini file located on the system volume of the previously discovered domain controller. The Group Policy service records this activity with a series of start and end-trace events (event ID 4017). You can use the corresponding end-trace event to determine the success or failure of each attempt to read the gpt.ini file.
|
Event ID
|
Explanation
|
|---|
5017 | Success end-trace event: The system call described in the event completed successfully. |
6017 | Warning end-trace event: The system call described in the event completed with one or more errors. |
7017 | Error end-trace event: The system call described in the event failed to complete. |
The following is example output of the start-trace events and end-trace events included in the GPO discovery scenario.
12:41:19.636 4017 Making system calls to access specified file. \\contoso.com\SysVol\contoso.com\Policies\{9F1DE622-0635-4F10-8A0B-4AEAEB5C3B79}\gpt.ini
12:41:20.307 5017 The system calls to access specified file completed. \\contoso.com\SysVol\contoso.com\Policies\{9F1DE622-0635-4F10-8A0B-4AEAEB5C3B79}\gpt.ini The call completed in 671 milliseconds.The Group Policy service continues the GPO discovery process by recording the applied GPO discovery list event.
Event ID 5312: Applied GPO list event
The Group Policy service records this event after it checks each Group Policy object's gpt.ini file. The details of the event include the names of Group Policy objects applicable to the computer or user.
|
Event ID
|
Explanation
|
|---|
5312 | Success applied GPO list event: The discovery of applicable Group Policy objects completed successfully. |
6312 | Warning applied GPO list event: The discovery of applicable Group Policy objects completed with one or more errors. |
7312 | Error applied GPO list event: The discovery of applicable Group Policy objects did not complete. |
The following is example output of a Applied GPO list event.
12:41:20.958 5312 List of applicable Group Policy objects: Removable Devices Policy
Power Management Policy
Folder Redirection Policy
Default Domain PolicyThe Group Policy service concludes the GPO discovery scenario by recording the filtered GPO list event.
Event ID 5313: Filtered GPO list event
The Group Policy service records this event at the conclusion of the GPO discovery scenario. The details of the event include the names of filtered Group Policy objects. The Group Policy service does not apply these GPOs to the computer or user.
|
Event ID
|
Explanation
|
|---|
5313 | Success filtered GPO list event: The discovery of filtered Group Policy objects completed successfully. |
6313 | Warning filtered GPO list event: The discovery of filtered Group Policy objects completed with one or more errors. |
7313 | Error filtered GPO list event: The discovery of filtered Group Policy objects did not complete. |
The following is example output of the entire GPO discovery scenario.
12:41:19.636 4017 Making system calls to access specified file. \\contoso.com\SysVol\contoso.com\Policies\{9F1DE622-0635-4F10-8A0B-4AEAEB5C3B79}\gpt.ini
12:41:20.307 5017 The system calls to access specified file completed. \\contoso.com\SysVol\contoso.com\Policies\{9F1DE622-0635-4F10-8A0B-4AEAEB5C3B79}\gpt.ini The call completed in 671 milliseconds.
12:41:20.307 4017 Making system calls to access specified file. \\contoso.com\SysVol\contoso.com\Policies\{1AAEB8CD-E71C-4D7F-A658-A5331ED8FEF0}\gpt.ini
12:41:20.598 5017 The system calls to access specified file completed. \\contoso.com\SysVol\contoso.com\Policies\{1AAEB8CD-E71C-4D7F-A658-A5331ED8FEF0}\gpt.ini The call completed in 290 milliseconds.
12:41:20.598 4017 Making system calls to access specified file. \\contoso.com\SysVol\contoso.com\Policies\{898264CC-84A5-4A77-95F6-402B30778048}\gpt.ini
12:41:20.648 5017 The system calls to access specified file completed. \\contoso.com\SysVol\contoso.com\Policies\{898264CC-84A5-4A77-95F6-402B30778048}\gpt.ini The call completed in 51 milliseconds.
12:41:20.648 4017 Making system calls to access specified file. \\contoso.com\SysVol\contoso.com\Policies\{CBBCB787-7FE6-45B3-89D3-38D74D658BA3}\gpt.ini
12:41:20.668 5017 The system calls to access specified file completed. \\contoso.com\SysVol\contoso.com\Policies\{CBBCB787-7FE6-45B3-89D3-38D74D658BA3}\gpt.ini The call completed in 20 milliseconds.
12:41:20.668 4017 Making system calls to access specified file. \\contoso.com\sysvol\contoso.com\Policies\{31B2F340-016D-11D2-945F-00C04FB984F9}\gpt.ini
12:41:20.848 5017 The system calls to access specified file completed. \\contoso.com\sysvol\contoso.com\Policies\{31B2F340-016D-11D2-945F-00C04FB984F9}\gpt.ini The call completed in 180 milliseconds.
12:41:20.958 5312 List of applicable Group Policy objects: Removable Devices Policy
Power Management Policy
Folder Redirection Policy
Default Domain Policy
12:41:20.958 5313 The following Group Policy objects were not applicable because they were filtered out : Local Group Policy
Not Applied (Empty)
Shell Restriction Policy
Not Applied (Empty)Scenario: Slow link detection
Several components of Group Policy rely on a fast network connection. However, sometimes a fast network connection is not available. The Group Policy service is responsible for detecting and estimating bandwidth between the computer and the domain controller. The Group Policy service compares the result of the estimated bandwidth to the slow link threshold (configured by Group Policy). A value below the threshold results in the Group Policy service flagging the network connection as a slow link.
The Group Policy service shares this information with each Group Policy client-side extension. Client-side extensions have a default behavior when they encounter a slow link. For example, the security client-side extension processes Group Policy settings, even when the network connection is slow. However, the folder redirection client-side extension does not process its Group Policy settings over a slow network connection.
Event ID 5327: Estimated bandwidth event
The Group Policy service records this event when it successfully estimates the network bandwidth of a network interface.
|
Event ID
|
Explanation
|
|---|
5327 | Success estimated bandwidth event: Estimating the bandwidth for a network interface completed successfully. |
6327 | Warning estimated bandwidth event: Estimating the bandwidth for a network interface completed with one or more errors. |
7327 | Error estimated bandwidth event: Estimating the bandwidth for a network interface did not complete. |
The Group Policy service includes the estimated bandwidth, measured in kilobits per second (Kbps), in success and warning events.
Important |
|---|
|
The Group Policy service uses all enabled network interfaces to determine the estimated bandwidth. It is important to remember this when troubleshooting computers with multiple network interfaces. The following is example output of a successful estimated bandwidth event |
12:41:22.991 5327 Estimated network bandwidth on one of the connections: 1408 kbps.
After estimating the network bandwidth, the Group Policy service records a Network information event.
Event ID 5314: Network information event
The Group Policy service records this event after it estimates the network bandwidth for the computer. Success and warning network information events include:
-
The connection is a fast or slow link.
-
The estimated bandwidth value, measured in Kbps.
-
The slow link bandwidth threshold, also measured in Kbps.
|
Event ID
|
Explanation
|
|---|
5314 | Success network information event: The Group Policy service successfully determined a slow or fast link. |
6314 | Warning network information event: The Group Policy service encountered one or more errors when determining a slow or fast link. |
7314 | Error network information event: The Group Policy service encountered an error when attempting to determine a slow or fast link. |
The following is example output of the slow link detection scenario
12:41:22.991 5327 Estimated network bandwidth on one of the connections: 1408 kbps.
12:41:22.991 5314 A fast link was detected. The Estimated bandwidth is 1408 kbps. The slow link threshold is 500 kbps.
Scenario: Nonsystem GP extension discovery
The Group Policy service runs in a shared service host process with other components included with Windows Vista. The service operating in this shared service host increases its performance. However, third party developers can extend Group Policy by providing additional extensions, which are processed during Group Policy processing. The Group Policy service detects for non-system extensions during the pre-processing phase of Group Policy processing. The service reconfigures itself to run in a separate service host process when it detects non-system extensions, also known as standalone mode.
The Group Policy service reports this information in the operational log using the operational information event.
Event ID 5320: Operational information event
The Group Policy service uses this event to display success information in the operational log. This event is not specific to any given phase or scenario within Group Policy processing. It is common for the event description to change for this event.
|
Event ID
|
Explanation
|
|---|
5320 | Success operational information event: The event description provides information or describes a successful event. |
6320 | Warning operational information event: The event description provides information about a recent warning event. |
73201 | Error operational informational event: The event description provides information about a recent error event. |
The following is example output of the non–system extension discovery process.
12:41:28.058 5320 Checking for Group Policy client extensions that are not part of the system.
12:41:28.058 5320 Service configuration update to standalone is not required and will be skipped.
12:41:28.058 5320 Finished checking for non-system extensions.