Automatic updates stopped working after SP3 has been installed

June 3, 2008

Hello,

We have a corporate WSUS server that all workstations use for getting

updates.

After installing SP3 on a new Windows XP box, that box stopped getting

updates. Its WindowsUpdate.log contains SOAP errors:

....

2008-06-03 19:07:43:222 1052 2f8 Setup * IsUpdateRequired = No

2008-06-03 19:07:43:300 1052 2f8 PT +++++++++++ PT: Synchronizing

server updates +++++++++++

2008-06-03 19:07:43:300 1052 2f8 PT + ServiceId =

{3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}, Server URL =

http://sus:8530/ClientWebService/client.asmx

2008-06-03 19:07:43:300 1052 2f8 Agent Switching to hardware-verified

ClientId.

2008-06-03 19:07:43:316 1052 2f8 PT WARNING: Cached cookie has expired

or new PID is available

2008-06-03 19:07:43:628 1052 2f8 Agent Created new random SusClientId

cf9b00aa-97a6-4a28-94e2-efdc0c094a7e. Old Id:

71b1e082-140e-45da-ad43-ba80b1e0cb59.

2008-06-03 19:07:43:628 1052 2f8 PT Initializing simple targeting

cookie, clientId = cf9b00aa-97a6-4a28-94e2-efdc0c094a7e, target group = ,

DNS name = comp.domain.biz

2008-06-03 19:07:43:628 1052 2f8 PT Server URL =

http://sus:8530/SimpleAuthWebService/SimpleAuth.asmx

2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SyncUpdates failure, error

= 0x8024400E, soap client error = 7, soap error code = 400, HTTP status code

= 200

2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SOAP Fault: 0x000190

2008-06-03 19:07:46:472 1052 2f8 PT WARNING: faultstring:Fault

occurred

2008-06-03 19:07:46:472 1052 2f8 PT WARNING:

ErrorCode:InternalServerError(5)

2008-06-03 19:07:46:472 1052 2f8 PT WARNING: Message:(null)

2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

Method:"http://www.microsoft.com/SoftwareDistribution/Server/ClientWebService/SyncUpdates"

2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

ID:31d3d97a-8284-4b2e-8e15-5996cf6d9576

2008-06-03 19:07:46:487 1052 2f8 PT WARNING: PTError: 0x8024400e

2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncUpdates_WithRecovery

failed.: 0x8024400e

2008-06-03 19:07:46:487 1052 2f8 PT WARNING: Sync of Updates: 0x8024400e

2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncServerUpdatesInternal

failed: 0x8024400e

2008-06-03 19:07:46:487 1052 2f8 Agent * WARNING: Failed to

synchronize, error = 0x8024400E

2008-06-03 19:07:46:503 1052 2f8 Agent * WARNING: Exit code =

0x8024400E

2008-06-03 19:07:46:503 1052 2f8 Agent *********

2008-06-03 19:07:46:503 1052 2f8 Agent ** END ** Agent: Finding

updates [CallerId = AutomaticUpdates]

2008-06-03 19:07:46:503 1052 2f8 Agent *************

2008-06-03 19:07:46:503 1052 2f8 Agent WARNING: WU client failed

Searching for update with error 0x8024400e

2008-06-03 19:07:46:503 1052 d10 AU >>## RESUMED ## AU: Search for

updates [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Search callback failed,

result = 0x8024400E

2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Failed to find updates

with error code 8024400E

2008-06-03 19:07:46:503 1052 d10 AU #########

2008-06-03 19:07:46:503 1052 d10 AU ## END ## AU: Search for updates

[CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

2008-06-03 19:07:46:503 1052 d10 AU #############

2008-06-03 19:07:46:503 1052 d10 AU AU setting next detection timeout to

2008-06-03 20:07:46

2008-06-03 19:07:51:502 1052 2f8 Report REPORT EVENT:

{5692A6B9-F894-4200-8B1F-C337D541B484} 2008-06-03 19:07:46:503+0400 1 148

101 {00000000-0000-0000-0000-000000000000} 0 8024400e AutomaticUpdates

Failure Software Synchronization Windows Update Client failed to detect

with error 0x8024400e.

WSUS server's SoftwareDistribution.log contains:

2008-06-03 15:07:46.561 UTC Error w3wp.6 ClientImplementation.SyncUpdates

System.ArgumentException: Item has already been added. Key in dictionary:

'19202' Key being added: '19202'

at System.Collections.Hashtable.Insert(Object key, Object nvalue, Boolean

add)

at System.Collections.Hashtable.Add(Object key, Object value)

at

Microsoft.UpdateServices.Internal.ClientImplementation.GetSyncInfo(DataAccess

dataAccess, Hashtable stateTable, Hashtable deploymentTable, Boolean

haveGroupsChanged, Boolean doChunking)

at

Microsoft.UpdateServices.Internal.ClientImplementation.SoftwareSync(DataAccess

dataAccess, UnencryptedCookieData cookieData, Int32[]

installedNonLeafUpdateIds, Int32[] leafUpdateIds, Boolean haveGroupsChanged,

Boolean expressQuery)

at

Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

cookie, SyncUpdateParameters parameters)

at

Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

cookie, SyncUpdateParameters parameters)

at Microsoft.UpdateServices.Internal.Client.SyncUpdates(Cookie cookie,

SyncUpdateParameters parameters)

at System.RuntimeMethodHandle._InvokeMethodFast(Object target, Object[]

arguments, SignatureStruct& sig, MethodAttributes methodAttributes,

RuntimeTypeHandle typeOwner)

at System.RuntimeMethodHandle.InvokeMethodFast(Object target, Object[]

arguments, Signature sig, MethodAttributes methodAttributes,

RuntimeTypeHandle typeOwner)

at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

invokeAttr, Binder binder, Object[] parameters, CultureInfo culture, Boolean

skipVisibilityChecks)

at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

invokeAttr, Binder binder, Object[] parameters, CultureInfo culture)

at System.Web.Services.Protocols.LogicalMethodInfo.Invoke(Object target,

Object[] values)

at System.Web.Services.Protocols.WebServiceHandler.Invoke()

at System.Web.Services.Protocols.WebServiceHandler.CoreProcessRequest()

at

System.Web.Services.Protocols.SyncSessionlessHandler.ProcessRequest(HttpContext

context)

at

System.Web.HttpApplication.CallHandlerExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute()

at System.Web.HttpApplication.ExecuteStep(IExecutionStep step, Boolean&

completedSynchronously)

at

System.Web.HttpApplication.ApplicationStepManager.ResumeSteps(Exception

error)

at

System.Web.HttpApplication.System.Web.IHttpAsyncHandler.BeginProcessRequest(HttpContext

context, AsyncCallback cb, Object extraData)

at System.Web.HttpRuntime.ProcessRequestInternal(HttpWorkerRequest wr)

at System.Web.HttpRuntime.ProcessRequestNoDemand(HttpWorkerRequest wr)

at System.Web.Hosting.ISAPIRuntime.ProcessRequest(IntPtr ecb, Int32

iWRType)

2008-06-03 15:07:46.576 UTC Warning w3wp.6 SoapUtilities.CreateException

ThrowException: actor = http://sus:8530/ClientWebService/client.asmx,

ID=31d3d97a-8284-4b2e-8e15-5996cf6d9576, ErrorCode=InternalServerError,

Message=, Client=?

I've tried to delete SusCliendId from workstation's registry,

SoftwareDistribution folder from workstation's Windows folder - nothing

helps.

All other workstations in AD domain are updating from that WSUS server

perfectly.

Please, help!

June 3, 2008

Try this.

net stop wuauserv

net stop bits

rename the c:\windows\software distribution folder

net start bits

net start wuauserv

If this doesn't fix it, then force a reinstall of the agent by downloading

http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.6

5/WindowsUpdateAgent30-x86.exe

and installing with the /wuforce switch

Eddie Bowers

Security Support

Microsoft Corporation

This posting is provided "AS IS" with no warranties, and confers no rights.

June 3, 2008

Forwarded to WSUS newsgroup

(microsoft.public.windows.server.update_services) via crosspost as a

convenience to OP.

On the web:

http://www.microsoft.com/communities/newsgroups/list/en-us/default.aspx?dg=microsoft.public.windows.server.update_services

In your newsreader:

http://news://msnews.microsoft.com/microsoft.public.windows.server.update_services

NB: Eddie Bowers [MSFT] posted a reply to this thread in WU NG:

<QP>

Try this.

net stop wuauserv

net stop bits

rename the c:\windows\software distribution folder

net start bits

net start wuauserv

If this doesn't fix it, then force a reinstall of the agent by downloading

http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.65/WindowsUpdateAgent30-x86.exe

and installing with the /wuforce switch

</QP>

--

~PA Bear

Alexander wrote:

> Hello,

>

> We have a corporate WSUS server that all workstations use for getting

> updates.

>

> After installing SP3 on a new Windows XP box, that box stopped getting

> updates. Its WindowsUpdate.log contains SOAP errors:

> ...

> 2008-06-03 19:07:43:222 1052 2f8 Setup * IsUpdateRequired = No

> 2008-06-03 19:07:43:300 1052 2f8 PT +++++++++++ PT: Synchronizing

> server updates +++++++++++

> 2008-06-03 19:07:43:300 1052 2f8 PT + ServiceId =

> {3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}, Server URL =

> http://sus:8530/ClientWebService/client.asmx

> 2008-06-03 19:07:43:300 1052 2f8 Agent Switching to hardware-verified

> ClientId.

> 2008-06-03 19:07:43:316 1052 2f8 PT WARNING: Cached cookie has expired

> or new PID is available

> 2008-06-03 19:07:43:628 1052 2f8 Agent Created new random SusClientId

> cf9b00aa-97a6-4a28-94e2-efdc0c094a7e. Old Id:

> 71b1e082-140e-45da-ad43-ba80b1e0cb59.

> 2008-06-03 19:07:43:628 1052 2f8 PT Initializing simple targeting

> cookie, clientId = cf9b00aa-97a6-4a28-94e2-efdc0c094a7e, target group = ,

> DNS name = comp.domain.biz

> 2008-06-03 19:07:43:628 1052 2f8 PT Server URL =

> http://sus:8530/SimpleAuthWebService/SimpleAuth.asmx

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SyncUpdates failure,

> error

> = 0x8024400E, soap client error = 7, soap error code = 400, HTTP status

> code

> = 200

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SOAP Fault: 0x000190

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: faultstring:Fault

> occurred

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING:

> ErrorCode:InternalServerError(5)

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: Message:(null)

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> Method:"http://www.microsoft.com/SoftwareDistribution/Server/ClientWebService/SyncUpdates"

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> ID:31d3d97a-8284-4b2e-8e15-5996cf6d9576

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: PTError: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncUpdates_WithRecovery

> failed.: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: Sync of Updates:

> 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncServerUpdatesInternal

> failed: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 Agent * WARNING: Failed to

> synchronize, error = 0x8024400E

> 2008-06-03 19:07:46:503 1052 2f8 Agent * WARNING: Exit code =

> 0x8024400E

> 2008-06-03 19:07:46:503 1052 2f8 Agent *********

> 2008-06-03 19:07:46:503 1052 2f8 Agent ** END ** Agent: Finding

> updates [CallerId = AutomaticUpdates]

> 2008-06-03 19:07:46:503 1052 2f8 Agent *************

> 2008-06-03 19:07:46:503 1052 2f8 Agent WARNING: WU client failed

> Searching for update with error 0x8024400e

> 2008-06-03 19:07:46:503 1052 d10 AU >>## RESUMED ## AU: Search for

> updates [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Search callback

> failed,

> result = 0x8024400E

> 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Failed to find

> updates

> with error code 8024400E

> 2008-06-03 19:07:46:503 1052 d10 AU #########

> 2008-06-03 19:07:46:503 1052 d10 AU ## END ## AU: Search for

> updates

> [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> 2008-06-03 19:07:46:503 1052 d10 AU #############

> 2008-06-03 19:07:46:503 1052 d10 AU AU setting next detection timeout

> to

> 2008-06-03 20:07:46

> 2008-06-03 19:07:51:502 1052 2f8 Report REPORT EVENT:

> {5692A6B9-F894-4200-8B1F-C337D541B484} 2008-06-03 19:07:46:503+0400 1

> 148

> 101 {00000000-0000-0000-0000-000000000000} 0 8024400e AutomaticUpdates

> Failure Software Synchronization Windows Update Client failed to detect

> with error 0x8024400e.

>

> WSUS server's SoftwareDistribution.log contains:

>

> 2008-06-03 15:07:46.561 UTC Error w3wp.6 ClientImplementation.SyncUpdates

> System.ArgumentException: Item has already been added. Key in dictionary:

> '19202' Key being added: '19202'

> at System.Collections.Hashtable.Insert(Object key, Object nvalue,

> Boolean

> add)

> at System.Collections.Hashtable.Add(Object key, Object value)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.GetSyncInfo(DataAccess

> dataAccess, Hashtable stateTable, Hashtable deploymentTable, Boolean

> haveGroupsChanged, Boolean doChunking)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SoftwareSync(DataAccess

> dataAccess, UnencryptedCookieData cookieData, Int32[]

> installedNonLeafUpdateIds, Int32[] leafUpdateIds, Boolean

> haveGroupsChanged,

> Boolean expressQuery)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> cookie, SyncUpdateParameters parameters)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> cookie, SyncUpdateParameters parameters)

> at Microsoft.UpdateServices.Internal.Client.SyncUpdates(Cookie cookie,

> SyncUpdateParameters parameters)

> at System.RuntimeMethodHandle._InvokeMethodFast(Object target, Object[]

> arguments, SignatureStruct& sig, MethodAttributes methodAttributes,

> RuntimeTypeHandle typeOwner)

> at System.RuntimeMethodHandle.InvokeMethodFast(Object target, Object[]

> arguments, Signature sig, MethodAttributes methodAttributes,

> RuntimeTypeHandle typeOwner)

> at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> invokeAttr, Binder binder, Object[] parameters, CultureInfo culture,

> Boolean

> skipVisibilityChecks)

> at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> invokeAttr, Binder binder, Object[] parameters, CultureInfo culture)

> at System.Web.Services.Protocols.LogicalMethodInfo.Invoke(Object target,

> Object[] values)

> at System.Web.Services.Protocols.WebServiceHandler.Invoke()

> at System.Web.Services.Protocols.WebServiceHandler.CoreProcessRequest()

> at

> System.Web.Services.Protocols.SyncSessionlessHandler.ProcessRequest(HttpContext

> context)

> at

> System.Web.HttpApplication.CallHandlerExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute()

> at System.Web.HttpApplication.ExecuteStep(IExecutionStep step, Boolean&

> completedSynchronously)

> at

> System.Web.HttpApplication.ApplicationStepManager.ResumeSteps(Exception

> error)

> at

> System.Web.HttpApplication.System.Web.IHttpAsyncHandler.BeginProcessRequest(HttpContext

> context, AsyncCallback cb, Object extraData)

> at System.Web.HttpRuntime.ProcessRequestInternal(HttpWorkerRequest wr)

> at System.Web.HttpRuntime.ProcessRequestNoDemand(HttpWorkerRequest wr)

> at System.Web.Hosting.ISAPIRuntime.ProcessRequest(IntPtr ecb, Int32

> iWRType)

> 2008-06-03 15:07:46.576 UTC Warning w3wp.6 SoapUtilities.CreateException

> ThrowException: actor = http://sus:8530/ClientWebService/client.asmx,

> ID=31d3d97a-8284-4b2e-8e15-5996cf6d9576, ErrorCode=InternalServerError,

> Message=, Client=?

>

> I've tried to delete SusCliendId from workstation's registry,

> SoftwareDistribution folder from workstation's Windows folder - nothing

> helps.

>

> All other workstations in AD domain are updating from that WSUS server

> perfectly.

>

> Please, help!

June 4, 2008

Thanks for your such a fast answer, Eddie!

Unfortunately, both of your suggestions didn't help.

I suppose, this is a problem on a server side, since it looks like a

duplicate key in database:

2008-06-03 15:07:46.561 UTC Error w3wp.6 ClientImplementation.SyncUpdates

System.ArgumentException: Item has already been added. Key in dictionary:

'19202' Key being added: '19202'

at System.Collections.Hashtable.Insert(Object key, Object nvalue, Boolean

add)

....

If you have any other suggestions, please, let me know!

"Eddie Bowers [MSFT]" <eddieb@online.microsoft.com> wrote in message

news:afaVwkZxIHA.4564@TK2MSFTNGHUB02.phx.gbl...

> Try this.

> net stop wuauserv

> net stop bits

> rename the c:\windows\software distribution folder

> net start bits

> net start wuauserv

>

> If this doesn't fix it, then force a reinstall of the agent by downloading

> http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.6

> 5/WindowsUpdateAgent30-x86.exe

> and installing with the /wuforce switch

June 4, 2008

How about this:

net stop wuauserv

Delete the following registry keys:

HKLM\SOFTWARE\Microsoft\Windows\CurrentVersion\WindowsUpdate\PingID

HKLM\SOFTWARE\Microsoft\Windows\CurrentVersion\WindowsUpdate\AccountDomainSi

d

HKLM\SOFTWARE\Microsoft\Windows\CurrentVersion\WindowsUpdate\SusClientId

net start wuauserv

wuauclt.exe /resetauthorization /detectnow

Eddie Bowers

Security Support

Microsoft Corporation

This posting is provided "AS IS" with no warranties, and confers no rights.

June 5, 2008

Just tried your suggestion. Since there are no PingID and AccountDomainSid,

I've deleted SusClientId only.

Not helped either

Looks like I've discovered the sequence of actions that led to the current

issue:

1. After installing SP3 warnings and soap errors came up

2. One of our IT support guys deleted SusClientId instead of removing

SoftwareDistribution folder

3. And now nothing helps

Any other thoughts?

"Eddie Bowers [MSFT]" <eddieb@online.microsoft.com> wrote in message

news:oF7vRQoxIHA.2252@TK2MSFTNGHUB02.phx.gbl...

> How about this:

>

> net stop wuauserv

>

> Delete the following registry keys:

>

> HKLM\SOFTWARE\Microsoft\Windows\CurrentVersion\WindowsUpdate\PingID

>

> HKLM\SOFTWARE\Microsoft\Windows\CurrentVersion\WindowsUpdate\AccountDomainSid

>

> HKLM\SOFTWARE\Microsoft\Windows\CurrentVersion\WindowsUpdate\SusClientId

>

> net start wuauserv

> wuauclt.exe /resetauthorization /detectnow

>

> Eddie Bowers

> Security Support

> Microsoft Corporation

>

> This posting is provided "AS IS" with no warranties, and confers no

> rights.

June 5, 2008

Is this the ONLY client machine that has this problem?

Most of the time this is a WSUS server side problem, but that would cause

all of your clients to fail.

How many computers check into your WSUS server?

Eddie Bowers

Security Support

Microsoft Corporation

This posting is provided "AS IS" with no warranties, and confers no rights.

June 6, 2008

It appears, there are two more clients that have such a problem: Windows

2000 SP4 and Windows XP SP1.

In total, there are approx. 50 computers that use WSUS server.

"Eddie Bowers [MSFT]" <eddieb@online.microsoft.com> wrote in message

news:0nXHwbyxIHA.1784@TK2MSFTNGHUB02.phx.gbl...

> Is this the ONLY client machine that has this problem?

> Most of the time this is a WSUS server side problem, but that would cause

> all of your clients to fail.

> How many computers check into your WSUS server?

June 9, 2008

OK, well lets try the shotgun approach to see what happnes. Run my tool

from:

http:\\http://www.codeplex.com\aureset

Eddie Bowers

Security Support

Microsoft Corporation

This posting is provided "AS IS" with no warranties, and confers no rights.

June 10, 2008

Hi Eddie,

This didn't help unfortunately. Do you need me to send generated log files

somewhere?

Please, mention, that couple of antiviruses thinks your software is a virus:

http://www.virustotal.com/analisis/e23a9b0bebcada0986f8502edd0fa454

"Eddie Bowers [MSFT]" <eddieb@online.microsoft.com> wrote in message

news:FsjMtPoyIHA.5796@TK2MSFTNGHUB02.phx.gbl...

> OK, well lets try the shotgun approach to see what happnes. Run my tool

> from:

> http:\\http://www.codeplex.com\aureset

June 11, 2008

Are the machines getting the error below on the same network segment as

those not getting the error?

( WARNING: SyncUpdates failure, error = 0x8024400E, soap client error = 7,

soap error code = 400)

The logs that the tool generates probably are not going to help with this.

I think at this point we would have to get a network trace and have you

open a case with us so we can really dig into it.

Thanks for the VirusTotal link. Thats interesting. I can see how what it

does would look suspect.

Eddie Bowers

Security Support

Microsoft Corporation

This posting is provided "AS IS" with no warranties, and confers no rights.

Hi Eddie,

This didn't help unfortunately. Do you need me to send generated log files

somewhere?

Please, mention, that couple of antiviruses thinks your software is a virus:

http://www.virustotal.com/analisis/e23a9b0bebcada0986f8502edd0fa454

"Eddie Bowers [MSFT]" <eddieb@online.microsoft.com> wrote in message

news:FsjMtPoyIHA.5796@TK2MSFTNGHUB02.phx.gbl...

> OK, well lets try the shotgun approach to see what happnes. Run my tool

> from:

> http:\\http://www.codeplex.com\aureset

June 15, 2008

I have the same problem:

WindowsUpdate.log shows:

WARNING: SyncUpdates failure, error = 0x8024400E, soap client error = 7,

soap error code = 400, HTTP status code = 200

WARNING: SOAP Fault: 0x000190

SoftwareDistribution.log shows:

Error w3wp.5 ClientImplementation.SyncUpdates System.ArgumentException:

Item has already been added. Key in dictionary: '8135' Key being added:

'8135'

Nothing helps, already tried:

1) wuauclt.exe /resetauthorization /detectnow

2) Deleted SoftwareDistribution Folder

3) WindowsUpdateAgent30-x86.exe /wuforce

4) Deleted SusClientId and Validation Registry Keys

It looks like a server side problem...

Any help is appreciated!

"PA Bear [MS MVP]" wrote:

> Forwarded to WSUS newsgroup

> (microsoft.public.windows.server.update_services) via crosspost as a

> convenience to OP.

>

> On the web:

> http://www.microsoft.com/communities/newsgroups/list/en-us/default.aspx?dg=microsoft.public.windows.server.update_services

>

> In your newsreader:

> http://news://msnews.microsoft.com/microsoft.public.windows.server.update_services

>

> NB: Eddie Bowers [MSFT] posted a reply to this thread in WU NG:

>

> <QP>

> Try this.

> net stop wuauserv

> net stop bits

> rename the c:\windows\software distribution folder

> net start bits

> net start wuauserv

>

> If this doesn't fix it, then force a reinstall of the agent by downloading

> http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.65/WindowsUpdateAgent30-x86.exe

> and installing with the /wuforce switch

> </QP>

> --

> ~PA Bear

>

> Alexander wrote:

> > Hello,

> >

> > We have a corporate WSUS server that all workstations use for getting

> > updates.

> >

> > After installing SP3 on a new Windows XP box, that box stopped getting

> > updates. Its WindowsUpdate.log contains SOAP errors:

> > ...

> > 2008-06-03 19:07:43:222 1052 2f8 Setup * IsUpdateRequired = No

> > 2008-06-03 19:07:43:300 1052 2f8 PT +++++++++++ PT: Synchronizing

> > server updates +++++++++++

> > 2008-06-03 19:07:43:300 1052 2f8 PT + ServiceId =

> > {3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}, Server URL =

> > http://sus:8530/ClientWebService/client.asmx

> > 2008-06-03 19:07:43:300 1052 2f8 Agent Switching to hardware-verified

> > ClientId.

> > 2008-06-03 19:07:43:316 1052 2f8 PT WARNING: Cached cookie has expired

> > or new PID is available

> > 2008-06-03 19:07:43:628 1052 2f8 Agent Created new random SusClientId

> > cf9b00aa-97a6-4a28-94e2-efdc0c094a7e. Old Id:

> > 71b1e082-140e-45da-ad43-ba80b1e0cb59.

> > 2008-06-03 19:07:43:628 1052 2f8 PT Initializing simple targeting

> > cookie, clientId = cf9b00aa-97a6-4a28-94e2-efdc0c094a7e, target group = ,

> > DNS name = comp.domain.biz

> > 2008-06-03 19:07:43:628 1052 2f8 PT Server URL =

> > http://sus:8530/SimpleAuthWebService/SimpleAuth.asmx

> > 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SyncUpdates failure,

> > error

> > = 0x8024400E, soap client error = 7, soap error code = 400, HTTP status

> > code

> > = 200

> > 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SOAP Fault: 0x000190

> > 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: faultstring:Fault

> > occurred

> > 2008-06-03 19:07:46:472 1052 2f8 PT WARNING:

> > ErrorCode:InternalServerError(5)

> > 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: Message:(null)

> > 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> > Method:"http://www.microsoft.com/SoftwareDistribution/Server/ClientWebService/SyncUpdates"

> > 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> > ID:31d3d97a-8284-4b2e-8e15-5996cf6d9576

> > 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: PTError: 0x8024400e

> > 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncUpdates_WithRecovery

> > failed.: 0x8024400e

> > 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: Sync of Updates:

> > 0x8024400e

> > 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncServerUpdatesInternal

> > failed: 0x8024400e

> > 2008-06-03 19:07:46:487 1052 2f8 Agent * WARNING: Failed to

> > synchronize, error = 0x8024400E

> > 2008-06-03 19:07:46:503 1052 2f8 Agent * WARNING: Exit code =

> > 0x8024400E

> > 2008-06-03 19:07:46:503 1052 2f8 Agent *********

> > 2008-06-03 19:07:46:503 1052 2f8 Agent ** END ** Agent: Finding

> > updates [CallerId = AutomaticUpdates]

> > 2008-06-03 19:07:46:503 1052 2f8 Agent *************

> > 2008-06-03 19:07:46:503 1052 2f8 Agent WARNING: WU client failed

> > Searching for update with error 0x8024400e

> > 2008-06-03 19:07:46:503 1052 d10 AU >>## RESUMED ## AU: Search for

> > updates [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> > 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Search callback

> > failed,

> > result = 0x8024400E

> > 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Failed to find

> > updates

> > with error code 8024400E

> > 2008-06-03 19:07:46:503 1052 d10 AU #########

> > 2008-06-03 19:07:46:503 1052 d10 AU ## END ## AU: Search for

> > updates

> > [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> > 2008-06-03 19:07:46:503 1052 d10 AU #############

> > 2008-06-03 19:07:46:503 1052 d10 AU AU setting next detection timeout

> > to

> > 2008-06-03 20:07:46

> > 2008-06-03 19:07:51:502 1052 2f8 Report REPORT EVENT:

> > {5692A6B9-F894-4200-8B1F-C337D541B484} 2008-06-03 19:07:46:503+0400 1

> > 148

> > 101 {00000000-0000-0000-0000-000000000000} 0 8024400e AutomaticUpdates

> > Failure Software Synchronization Windows Update Client failed to detect

> > with error 0x8024400e.

> >

> > WSUS server's SoftwareDistribution.log contains:

> >

> > 2008-06-03 15:07:46.561 UTC Error w3wp.6 ClientImplementation.SyncUpdates

> > System.ArgumentException: Item has already been added. Key in dictionary:

> > '19202' Key being added: '19202'

> > at System.Collections.Hashtable.Insert(Object key, Object nvalue,

> > Boolean

> > add)

> > at System.Collections.Hashtable.Add(Object key, Object value)

> > at

> > Microsoft.UpdateServices.Internal.ClientImplementation.GetSyncInfo(DataAccess

> > dataAccess, Hashtable stateTable, Hashtable deploymentTable, Boolean

> > haveGroupsChanged, Boolean doChunking)

> > at

> > Microsoft.UpdateServices.Internal.ClientImplementation.SoftwareSync(DataAccess

> > dataAccess, UnencryptedCookieData cookieData, Int32[]

> > installedNonLeafUpdateIds, Int32[] leafUpdateIds, Boolean

> > haveGroupsChanged,

> > Boolean expressQuery)

> > at

> > Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> > cookie, SyncUpdateParameters parameters)

> > at

> > Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> > cookie, SyncUpdateParameters parameters)

> > at Microsoft.UpdateServices.Internal.Client.SyncUpdates(Cookie cookie,

> > SyncUpdateParameters parameters)

> > at System.RuntimeMethodHandle._InvokeMethodFast(Object target, Object[]

> > arguments, SignatureStruct& sig, MethodAttributes methodAttributes,

> > RuntimeTypeHandle typeOwner)

> > at System.RuntimeMethodHandle.InvokeMethodFast(Object target, Object[]

> > arguments, Signature sig, MethodAttributes methodAttributes,

> > RuntimeTypeHandle typeOwner)

> > at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> > invokeAttr, Binder binder, Object[] parameters, CultureInfo culture,

> > Boolean

> > skipVisibilityChecks)

> > at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> > invokeAttr, Binder binder, Object[] parameters, CultureInfo culture)

> > at System.Web.Services.Protocols.LogicalMethodInfo.Invoke(Object target,

> > Object[] values)

> > at System.Web.Services.Protocols.WebServiceHandler.Invoke()

> > at System.Web.Services.Protocols.WebServiceHandler.CoreProcessRequest()

> > at

> > System.Web.Services.Protocols.SyncSessionlessHandler.ProcessRequest(HttpContext

> > context)

> > at

> > System.Web.HttpApplication.CallHandlerExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute()

> > at System.Web.HttpApplication.ExecuteStep(IExecutionStep step, Boolean&

> > completedSynchronously)

> > at

> > System.Web.HttpApplication.ApplicationStepManager.ResumeSteps(Exception

> > error)

> > at

> > System.Web.HttpApplication.System.Web.IHttpAsyncHandler.BeginProcessRequest(HttpContext

> > context, AsyncCallback cb, Object extraData)

> > at System.Web.HttpRuntime.ProcessRequestInternal(HttpWorkerRequest wr)

> > at System.Web.HttpRuntime.ProcessRequestNoDemand(HttpWorkerRequest wr)

> > at System.Web.Hosting.ISAPIRuntime.ProcessRequest(IntPtr ecb, Int32

> > iWRType)

> > 2008-06-03 15:07:46.576 UTC Warning w3wp.6 SoapUtilities.CreateException

> > ThrowException: actor = http://sus:8530/ClientWebService/client.asmx,

> > ID=31d3d97a-8284-4b2e-8e15-5996cf6d9576, ErrorCode=InternalServerError,

> > Message=, Client=?

> >

> > I've tried to delete SusCliendId from workstation's registry,

> > SoftwareDistribution folder from workstation's Windows folder - nothing

> > helps.

> >

> > All other workstations in AD domain are updating from that WSUS server

> > perfectly.

> >

> > Please, help!

>

June 17, 2008

Also now have the same. PC was XP2 and not on the domain. Installed SP3, then

joined domain and used wuauclt /detectnow to force a check-in.

Getting SOAP errors, etc and "duplicate key" in softwaredistribution.log on

WSUS server

Tried the usual steps... resetauth, delete SusclientID, etc, etc.

reinstalled Update Agent

Any known fix for this?

[PC is being set-up for a user who's current PC has issues. So renamed PC

for them so I could create a new one. Have named the 'new' PC the same as the

one with issues used to be called. I suspect the issue may lie with this in

the WSUS db?]

June 17, 2008

I was having the same problems, but managed to fix the problem by

reinstalling the WUA with /wuforce, as per Eddie's first set of instructions.

However, please note that the download locations that Eddie provided for the

WUA are for the very latest version of WUA, 7.1.6001.65:

http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.65/WindowsUpdateAgent30-x86.exe

http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.65/WindowsUpdateAgent30-x64.exe

This is *not* the version of the WUA standalone executable that most people

have. Most people are still using version 7.0.6000.381, which is the one that

Microsoft are still distributing via Wuredist.cab (see

http://msdn.microsoft.com/en-us/library/aa387285(VS.85).aspx).

When I tried installing version 7.1.6001.65 with /wuforce, it fixed the

problem for me.

Regards,

--

Chris Hill

ICT Technician - Colchester Royal Grammar School

"Alexander" wrote:

> Hello,

>

> We have a corporate WSUS server that all workstations use for getting

> updates.

>

> After installing SP3 on a new Windows XP box, that box stopped getting

> updates. Its WindowsUpdate.log contains SOAP errors:

> ....

> 2008-06-03 19:07:43:222 1052 2f8 Setup * IsUpdateRequired = No

> 2008-06-03 19:07:43:300 1052 2f8 PT +++++++++++ PT: Synchronizing

> server updates +++++++++++

> 2008-06-03 19:07:43:300 1052 2f8 PT + ServiceId =

> {3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}, Server URL =

> http://sus:8530/ClientWebService/client.asmx

> 2008-06-03 19:07:43:300 1052 2f8 Agent Switching to hardware-verified

> ClientId.

> 2008-06-03 19:07:43:316 1052 2f8 PT WARNING: Cached cookie has expired

> or new PID is available

> 2008-06-03 19:07:43:628 1052 2f8 Agent Created new random SusClientId

> cf9b00aa-97a6-4a28-94e2-efdc0c094a7e. Old Id:

> 71b1e082-140e-45da-ad43-ba80b1e0cb59.

> 2008-06-03 19:07:43:628 1052 2f8 PT Initializing simple targeting

> cookie, clientId = cf9b00aa-97a6-4a28-94e2-efdc0c094a7e, target group = ,

> DNS name = comp.domain.biz

> 2008-06-03 19:07:43:628 1052 2f8 PT Server URL =

> http://sus:8530/SimpleAuthWebService/SimpleAuth.asmx

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SyncUpdates failure, error

> = 0x8024400E, soap client error = 7, soap error code = 400, HTTP status code

> = 200

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SOAP Fault: 0x000190

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: faultstring:Fault

> occurred

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING:

> ErrorCode:InternalServerError(5)

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: Message:(null)

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> Method:"http://www.microsoft.com/SoftwareDistribution/Server/ClientWebService/SyncUpdates"

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> ID:31d3d97a-8284-4b2e-8e15-5996cf6d9576

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: PTError: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncUpdates_WithRecovery

> failed.: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: Sync of Updates: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncServerUpdatesInternal

> failed: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 Agent * WARNING: Failed to

> synchronize, error = 0x8024400E

> 2008-06-03 19:07:46:503 1052 2f8 Agent * WARNING: Exit code =

> 0x8024400E

> 2008-06-03 19:07:46:503 1052 2f8 Agent *********

> 2008-06-03 19:07:46:503 1052 2f8 Agent ** END ** Agent: Finding

> updates [CallerId = AutomaticUpdates]

> 2008-06-03 19:07:46:503 1052 2f8 Agent *************

> 2008-06-03 19:07:46:503 1052 2f8 Agent WARNING: WU client failed

> Searching for update with error 0x8024400e

> 2008-06-03 19:07:46:503 1052 d10 AU >>## RESUMED ## AU: Search for

> updates [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Search callback failed,

> result = 0x8024400E

> 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Failed to find updates

> with error code 8024400E

> 2008-06-03 19:07:46:503 1052 d10 AU #########

> 2008-06-03 19:07:46:503 1052 d10 AU ## END ## AU: Search for updates

> [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> 2008-06-03 19:07:46:503 1052 d10 AU #############

> 2008-06-03 19:07:46:503 1052 d10 AU AU setting next detection timeout to

> 2008-06-03 20:07:46

> 2008-06-03 19:07:51:502 1052 2f8 Report REPORT EVENT:

> {5692A6B9-F894-4200-8B1F-C337D541B484} 2008-06-03 19:07:46:503+0400 1 148

> 101 {00000000-0000-0000-0000-000000000000} 0 8024400e AutomaticUpdates

> Failure Software Synchronization Windows Update Client failed to detect

> with error 0x8024400e.

>

> WSUS server's SoftwareDistribution.log contains:

>

> 2008-06-03 15:07:46.561 UTC Error w3wp.6 ClientImplementation.SyncUpdates

> System.ArgumentException: Item has already been added. Key in dictionary:

> '19202' Key being added: '19202'

> at System.Collections.Hashtable.Insert(Object key, Object nvalue, Boolean

> add)

> at System.Collections.Hashtable.Add(Object key, Object value)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.GetSyncInfo(DataAccess

> dataAccess, Hashtable stateTable, Hashtable deploymentTable, Boolean

> haveGroupsChanged, Boolean doChunking)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SoftwareSync(DataAccess

> dataAccess, UnencryptedCookieData cookieData, Int32[]

> installedNonLeafUpdateIds, Int32[] leafUpdateIds, Boolean haveGroupsChanged,

> Boolean expressQuery)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> cookie, SyncUpdateParameters parameters)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> cookie, SyncUpdateParameters parameters)

> at Microsoft.UpdateServices.Internal.Client.SyncUpdates(Cookie cookie,

> SyncUpdateParameters parameters)

> at System.RuntimeMethodHandle._InvokeMethodFast(Object target, Object[]

> arguments, SignatureStruct& sig, MethodAttributes methodAttributes,

> RuntimeTypeHandle typeOwner)

> at System.RuntimeMethodHandle.InvokeMethodFast(Object target, Object[]

> arguments, Signature sig, MethodAttributes methodAttributes,

> RuntimeTypeHandle typeOwner)

> at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> invokeAttr, Binder binder, Object[] parameters, CultureInfo culture, Boolean

> skipVisibilityChecks)

> at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> invokeAttr, Binder binder, Object[] parameters, CultureInfo culture)

> at System.Web.Services.Protocols.LogicalMethodInfo.Invoke(Object target,

> Object[] values)

> at System.Web.Services.Protocols.WebServiceHandler.Invoke()

> at System.Web.Services.Protocols.WebServiceHandler.CoreProcessRequest()

> at

> System.Web.Services.Protocols.SyncSessionlessHandler.ProcessRequest(HttpContext

> context)

> at

> System.Web.HttpApplication.CallHandlerExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute()

> at System.Web.HttpApplication.ExecuteStep(IExecutionStep step, Boolean&

> completedSynchronously)

> at

> System.Web.HttpApplication.ApplicationStepManager.ResumeSteps(Exception

> error)

> at

> System.Web.HttpApplication.System.Web.IHttpAsyncHandler.BeginProcessRequest(HttpContext

> context, AsyncCallback cb, Object extraData)

> at System.Web.HttpRuntime.ProcessRequestInternal(HttpWorkerRequest wr)

> at System.Web.HttpRuntime.ProcessRequestNoDemand(HttpWorkerRequest wr)

> at System.Web.Hosting.ISAPIRuntime.ProcessRequest(IntPtr ecb, Int32

> iWRType)

> 2008-06-03 15:07:46.576 UTC Warning w3wp.6 SoapUtilities.CreateException

> ThrowException: actor = http://sus:8530/ClientWebService/client.asmx,

> ID=31d3d97a-8284-4b2e-8e15-5996cf6d9576, ErrorCode=InternalServerError,

> Message=, Client=?

>

> I've tried to delete SusCliendId from workstation's registry,

> SoftwareDistribution folder from workstation's Windows folder - nothing

> helps.

>

> All other workstations in AD domain are updating from that WSUS server

> perfectly.

>

> Please, help!

>

June 17, 2008

Thanks for the info, Chris.

I'll give that a go when I'm back in work tomorrow.

I do know that my client PCs are on 7.1.6001.65 as .log file states no

update required for Agent files.

I'll respond tomorrow with results.

Thanks

Craig

"Christopher Hill" wrote:

> I was having the same problems, but managed to fix the problem by

> reinstalling the WUA with /wuforce, as per Eddie's first set of instructions.

> However, please note that the download locations that Eddie provided for the

> WUA are for the very latest version of WUA, 7.1.6001.65:

>

> http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.65/WindowsUpdateAgent30-x86.exe

> http://download.windowsupdate.com/WindowsUpdate/redist/standalone/7.1.6001.65/WindowsUpdateAgent30-x64.exe

>

> This is *not* the version of the WUA standalone executable that most people

> have. Most people are still using version 7.0.6000.381, which is the one that

> Microsoft are still distributing via Wuredist.cab (see

> http://msdn.microsoft.com/en-us/library/aa387285(VS.85).aspx).

>

> When I tried installing version 7.1.6001.65 with /wuforce, it fixed the

> problem for me.

>

> Regards,

> --

> Chris Hill

> ICT Technician - Colchester Royal Grammar School

>

June 18, 2008

Hi,

I have the same issues with the duplicate key being created with a new

laptop joining the network. I tried reinstalling the client OS and rejoining

but with the same results, admitedly I gave the client the same machine name.

This is the 50th client to join the WSUS server. Anyone found a fix yet?

Thanks

Chris

"Alexander" wrote:

> Hello,

>

> We have a corporate WSUS server that all workstations use for getting

> updates.

>

> After installing SP3 on a new Windows XP box, that box stopped getting

> updates. Its WindowsUpdate.log contains SOAP errors:

> ....

> 2008-06-03 19:07:43:222 1052 2f8 Setup * IsUpdateRequired = No

> 2008-06-03 19:07:43:300 1052 2f8 PT +++++++++++ PT: Synchronizing

> server updates +++++++++++

> 2008-06-03 19:07:43:300 1052 2f8 PT + ServiceId =

> {3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}, Server URL =

> http://sus:8530/ClientWebService/client.asmx

> 2008-06-03 19:07:43:300 1052 2f8 Agent Switching to hardware-verified

> ClientId.

> 2008-06-03 19:07:43:316 1052 2f8 PT WARNING: Cached cookie has expired

> or new PID is available

> 2008-06-03 19:07:43:628 1052 2f8 Agent Created new random SusClientId

> cf9b00aa-97a6-4a28-94e2-efdc0c094a7e. Old Id:

> 71b1e082-140e-45da-ad43-ba80b1e0cb59.

> 2008-06-03 19:07:43:628 1052 2f8 PT Initializing simple targeting

> cookie, clientId = cf9b00aa-97a6-4a28-94e2-efdc0c094a7e, target group = ,

> DNS name = comp.domain.biz

> 2008-06-03 19:07:43:628 1052 2f8 PT Server URL =

> http://sus:8530/SimpleAuthWebService/SimpleAuth.asmx

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SyncUpdates failure, error

> = 0x8024400E, soap client error = 7, soap error code = 400, HTTP status code

> = 200

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: SOAP Fault: 0x000190

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: faultstring:Fault

> occurred

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING:

> ErrorCode:InternalServerError(5)

> 2008-06-03 19:07:46:472 1052 2f8 PT WARNING: Message:(null)

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> Method:"http://www.microsoft.com/SoftwareDistribution/Server/ClientWebService/SyncUpdates"

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING:

> ID:31d3d97a-8284-4b2e-8e15-5996cf6d9576

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: PTError: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncUpdates_WithRecovery

> failed.: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: Sync of Updates: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 PT WARNING: SyncServerUpdatesInternal

> failed: 0x8024400e

> 2008-06-03 19:07:46:487 1052 2f8 Agent * WARNING: Failed to

> synchronize, error = 0x8024400E

> 2008-06-03 19:07:46:503 1052 2f8 Agent * WARNING: Exit code =

> 0x8024400E

> 2008-06-03 19:07:46:503 1052 2f8 Agent *********

> 2008-06-03 19:07:46:503 1052 2f8 Agent ** END ** Agent: Finding

> updates [CallerId = AutomaticUpdates]

> 2008-06-03 19:07:46:503 1052 2f8 Agent *************

> 2008-06-03 19:07:46:503 1052 2f8 Agent WARNING: WU client failed

> Searching for update with error 0x8024400e

> 2008-06-03 19:07:46:503 1052 d10 AU >>## RESUMED ## AU: Search for

> updates [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Search callback failed,

> result = 0x8024400E

> 2008-06-03 19:07:46:503 1052 d10 AU # WARNING: Failed to find updates

> with error code 8024400E

> 2008-06-03 19:07:46:503 1052 d10 AU #########

> 2008-06-03 19:07:46:503 1052 d10 AU ## END ## AU: Search for updates

> [CallId = {B28CD805-76E7-42F9-8F75-84ADA98269AC}]

> 2008-06-03 19:07:46:503 1052 d10 AU #############

> 2008-06-03 19:07:46:503 1052 d10 AU AU setting next detection timeout to

> 2008-06-03 20:07:46

> 2008-06-03 19:07:51:502 1052 2f8 Report REPORT EVENT:

> {5692A6B9-F894-4200-8B1F-C337D541B484} 2008-06-03 19:07:46:503+0400 1 148

> 101 {00000000-0000-0000-0000-000000000000} 0 8024400e AutomaticUpdates

> Failure Software Synchronization Windows Update Client failed to detect

> with error 0x8024400e.

>

> WSUS server's SoftwareDistribution.log contains:

>

> 2008-06-03 15:07:46.561 UTC Error w3wp.6 ClientImplementation.SyncUpdates

> System.ArgumentException: Item has already been added. Key in dictionary:

> '19202' Key being added: '19202'

> at System.Collections.Hashtable.Insert(Object key, Object nvalue, Boolean

> add)

> at System.Collections.Hashtable.Add(Object key, Object value)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.GetSyncInfo(DataAccess

> dataAccess, Hashtable stateTable, Hashtable deploymentTable, Boolean

> haveGroupsChanged, Boolean doChunking)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SoftwareSync(DataAccess

> dataAccess, UnencryptedCookieData cookieData, Int32[]

> installedNonLeafUpdateIds, Int32[] leafUpdateIds, Boolean haveGroupsChanged,

> Boolean expressQuery)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> cookie, SyncUpdateParameters parameters)

> at

> Microsoft.UpdateServices.Internal.ClientImplementation.SyncUpdates(Cookie

> cookie, SyncUpdateParameters parameters)

> at Microsoft.UpdateServices.Internal.Client.SyncUpdates(Cookie cookie,

> SyncUpdateParameters parameters)

> at System.RuntimeMethodHandle._InvokeMethodFast(Object target, Object[]

> arguments, SignatureStruct& sig, MethodAttributes methodAttributes,

> RuntimeTypeHandle typeOwner)

> at System.RuntimeMethodHandle.InvokeMethodFast(Object target, Object[]

> arguments, Signature sig, MethodAttributes methodAttributes,

> RuntimeTypeHandle typeOwner)

> at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> invokeAttr, Binder binder, Object[] parameters, CultureInfo culture, Boolean

> skipVisibilityChecks)

> at System.Reflection.RuntimeMethodInfo.Invoke(Object obj, BindingFlags

> invokeAttr, Binder binder, Object[] parameters, CultureInfo culture)

> at System.Web.Services.Protocols.LogicalMethodInfo.Invoke(Object target,

> Object[] values)

> at System.Web.Services.Protocols.WebServiceHandler.Invoke()

> at System.Web.Services.Protocols.WebServiceHandler.CoreProcessRequest()

> at

> System.Web.Services.Protocols.SyncSessionlessHandler.ProcessRequest(HttpContext

> context)

> at

> System.Web.HttpApplication.CallHandlerExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute()

> at System.Web.HttpApplication.ExecuteStep(IExecutionStep step, Boolean&

> completedSynchronously)

> at

> System.Web.HttpApplication.ApplicationStepManager.ResumeSteps(Exception

> error)

> at

> System.Web.HttpApplication.System.Web.IHttpAsyncHandler.BeginProcessRequest(HttpContext

> context, AsyncCallback cb, Object extraData)

> at System.Web.HttpRuntime.ProcessRequestInternal(HttpWorkerRequest wr)

> at System.Web.HttpRuntime.ProcessRequestNoDemand(HttpWorkerRequest wr)

> at System.Web.Hosting.ISAPIRuntime.ProcessRequest(IntPtr ecb, Int32

> iWRType)

> 2008-06-03 15:07:46.576 UTC Warning w3wp.6 SoapUtilities.CreateException

> ThrowException: actor = http://sus:8530/ClientWebService/client.asmx,

> ID=31d3d97a-8284-4b2e-8e15-5996cf6d9576, ErrorCode=InternalServerError,

> Message=, Client=?

>

> I've tried to delete SusCliendId from workstation's registry,

> SoftwareDistribution folder from workstation's Windows folder - nothing

> helps.

>

> All other workstations in AD domain are updating from that WSUS server

> perfectly.

>

> Please, help!

>

June 18, 2008

It was looking good up until I forced a detection using wuauclt /detectnow....

Once I'd installed (using /wuforce) the Agent update, the PC checked into

WSUS, yet reported 0 Updates Required (which was odd, as I'd just approved a

whole bunch load of June's updates yesterday morning)

Then I forced a checkin, and it failed with the same error as before.

This was done on a totally different PC (using a toally different image that

I'd pushed out to 3 PCs last week with problems)

The PC appears in WSUS with status as "Not reported in yet"

WindowsUpdate.log: (sorry for large log spam)

2008-06-18 08:49:57:875 1028 5ac Agent *********** Agent: Initializing

Windows Update Agent ***********

2008-06-18 08:49:57:875 1028 5ac Agent *********** Agent: Initializing

global settings cache ***********

2008-06-18 08:49:57:875 1028 5ac Agent * WSUS server: http://wsus-01

2008-06-18 08:49:57:875 1028 5ac Agent * WSUS status server:

http://ukmy-wsus-01

2008-06-18 08:49:57:875 1028 5ac Agent * Target group: UKMY Computer

Accounts

2008-06-18 08:49:57:875 1028 5ac Agent * Windows Update access disabled: No

2008-06-18 08:49:58:406 1028 538 Report *********** Report: Initializing

static reporting data ***********

2008-06-18 08:49:58:406 1028 538 Report * OS Version = 5.1.2600.2.0.65792

2008-06-18 08:49:58:500 1028 538 Report * Computer Brand = Dell Computer

Corporation

2008-06-18 08:49:58:500 1028 538 Report * Computer Model = OptiPlex SX270

2008-06-18 08:49:58:500 1028 538 Report * Bios Revision = A06

2008-06-18 08:49:58:500 1028 538 Report * Bios Name = Phoenix ROM BIOS

PLUS Version 1.10 A06

2008-06-18 08:49:58:500 1028 538 Report * Bios Release Date =

2004-09-29T00:00:00

2008-06-18 08:49:58:500 1028 538 Report * Locale ID = 1033

2008-06-18 08:50:00:656 3708 e80 Misc =========== Logging initialized

(build: 7.1.6001.65, tz: +0100) ===========

2008-06-18 08:50:00:656 3708 e80 Misc = Process:

C:\WINDOWS\system32\wuauclt.exe

2008-06-18 08:50:00:656 3708 e80 Misc = Module:

C:\WINDOWS\system32\wuaueng.dll

2008-06-18 08:50:00:656 3708 e80 DtaStor Default service for AU is

{00000000-0000-0000-0000-000000000000}

2008-06-18 08:50:00:719 3708 e80 DtaStor Default service for AU is

{9482F4B4-E343-43B6-B170-9A65BC822C77}

2008-06-18 08:50:00:734 1028 5ac Agent WARNING: Failed to read the service

id for re-registration 0x80070002

2008-06-18 08:50:00:734 1028 5ac Agent WARNING: Missing service entry in the

backup data store cleaning up

2008-06-18 08:50:00:734 1028 5ac DnldMgr Download manager restoring 0

downloads

2008-06-18 08:50:00:734 1028 5ac AU ########### AU: Initializing Automatic

Updates ###########

2008-06-18 08:50:00:734 1028 5ac AU # WSUS server: http://wsus-01

2008-06-18 08:50:00:734 1028 5ac AU # Detection frequency: 22

2008-06-18 08:50:00:734 1028 5ac AU # Target group: UKMY Computer Accounts

2008-06-18 08:50:00:734 1028 5ac AU # Approval type: Scheduled (Policy)

2008-06-18 08:50:00:734 1028 5ac AU # Scheduled install day/time: Every

day at 5:00

2008-06-18 08:50:00:734 1028 5ac AU # Auto-install minor updates: Yes

(Policy)

2008-06-18 08:50:00:734 1028 5ac AU # Will interact with non-admins

(Non-admins are elevated)

2008-06-18 08:50:00:781 1028 5ac AU Setting AU scheduled install time to

2008-06-19 04:00:00

2008-06-18 08:50:00:781 1028 5ac AU AU finished delayed initialization

2008-06-18 08:50:00:781 1028 538 AU #############

2008-06-18 08:50:00:781 1028 538 AU ## START ## AU: Search for updates

2008-06-18 08:50:00:781 1028 538 AU #########

2008-06-18 08:50:00:781 1028 538 AU <<## SUBMITTED ## AU: Search for updates

[CallId = {07050A77-AAAC-4E4A-990F-7E234A90D619}]

2008-06-18 08:50:00:781 1028 d4c Agent *************

2008-06-18 08:50:00:781 1028 d4c Agent ** START ** Agent: Finding updates

[CallerId = AutomaticUpdates]

2008-06-18 08:50:00:781 1028 d4c Agent *********

2008-06-18 08:50:00:781 1028 d4c Agent * Online = No Ignore download

priority = No

2008-06-18 08:50:00:781 1028 d4c Agent * Criteria = "IsHidden=0 and

IsInstalled=0 and DeploymentAction='Installation' and IsAssigned=1 or

IsHidden=0 and IsPresent=1 and DeploymentAction='Uninstallation' and

IsAssigned=1 or IsHidden=0 and IsInstalled=1 and

DeploymentAction='Installation' and IsAssigned=1 and RebootRequired=1 or

IsHidden=0 and IsInstalled=0 and DeploymentAction='Uninstallation' and

IsAssigned=1 and RebootRequired=1"

2008-06-18 08:50:00:781 1028 d4c Agent * ServiceID =

{3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}

2008-06-18 08:50:00:922 1028 d4c Agent * Found 0 updates and 0 categories

in search evaluated appl. rules of 0 out of 0 deployed entities

2008-06-18 08:50:00:922 1028 d4c Agent *********

2008-06-18 08:50:00:922 1028 d4c Agent ** END ** Agent: Finding updates

[CallerId = AutomaticUpdates]

2008-06-18 08:50:00:922 1028 d4c Agent *************

2008-06-18 08:50:00:922 1028 ec0 AU >>## RESUMED ## AU: Search for updates

[CallId = {07050A77-AAAC-4E4A-990F-7E234A90D619}]

2008-06-18 08:50:00:922 1028 ec0 AU # 0 updates detected

2008-06-18 08:50:00:922 1028 ec0 AU #########

2008-06-18 08:50:00:922 1028 ec0 AU ## END ## AU: Search for updates

[CallId = {07050A77-AAAC-4E4A-990F-7E234A90D619}]

2008-06-18 08:50:00:922 1028 ec0 AU #############

2008-06-18 08:50:01:734 1028 538 AU ########### AU: Uninitializing

Automatic Updates ###########

2008-06-18 08:50:01:766 1028 538 Report REPORT EVENT:

{A704EAAA-BF7C-4946-BD37-2500A585E0C8} 2008-06-18

08:50:00:781+0100 1 202 102 {00000000-0000-0000-0000-000000000000} 0 0 AutomaticUpdates Success Content Install Reboot completed.

2008-06-18 08:50:01:781 1028 538 Service *********

2008-06-18 08:50:01:781 1028 538 Service ** END ** Service: Service exit

[Exit code = 0x240001]

2008-06-18 08:50:01:781 1028 538 Service *************

2008-06-18 08:50:45:468 1068 108 Misc =========== Logging initialized

(build: 7.1.6001.65, tz: +0100) ===========

2008-06-18 08:50:45:484 1068 108 Misc = Process:

C:\WINDOWS\System32\svchost.exe

2008-06-18 08:50:45:500 1068 108 Misc = Module:

C:\WINDOWS\system32\wuaueng.dll

2008-06-18 08:50:45:468 1068 108 Service *************

2008-06-18 08:50:45:500 1068 108 Service ** START ** Service: Service startup

2008-06-18 08:50:45:500 1068 108 Service *********

2008-06-18 08:50:45:843 1068 108 Misc Registering binary:

C:\WINDOWS\system32\regsvr32.exe /s "C:\WINDOWS\system32\wups.dll"

2008-06-18 08:50:46:468 1068 108 Misc Registering binary:

C:\WINDOWS\system32\regsvr32.exe /s "C:\WINDOWS\system32\wups2.dll"

2008-06-18 08:50:46:890 1068 108 Agent * WU client version 7.1.6001.65

2008-06-18 08:50:46:890 1068 108 Agent * Base directory:

C:\WINDOWS\SoftwareDistribution

2008-06-18 08:50:46:953 1068 108 Agent * Access type: No proxy

2008-06-18 08:50:46:953 1068 108 Agent * Network state: Connected

2008-06-18 08:51:32:583 1068 108 Agent *********** Agent: Initializing

Windows Update Agent ***********

2008-06-18 08:51:32:583 1068 108 Agent *********** Agent: Initializing

global settings cache ***********

2008-06-18 08:51:32:583 1068 108 Agent * WSUS server: http://wsus-01

2008-06-18 08:51:32:583 1068 108 Agent * WSUS status server:

http://ukmy-wsus-01

2008-06-18 08:51:32:583 1068 108 Agent * Target group: UKMY Computer

Accounts

2008-06-18 08:51:32:583 1068 108 Agent * Windows Update access disabled: No

2008-06-18 08:51:32:598 1068 108 DnldMgr Download manager restoring 0

downloads

2008-06-18 08:51:32:598 1068 108 AU ########### AU: Initializing Automatic

Updates ###########

2008-06-18 08:51:32:598 1068 108 AU # WSUS server: http://wsus-01

2008-06-18 08:51:32:598 1068 108 AU # Detection frequency: 22

2008-06-18 08:51:32:598 1068 108 AU # Target group: UKMY Computer Accounts

2008-06-18 08:51:32:598 1068 108 AU # Approval type: Scheduled (Policy)

2008-06-18 08:51:32:598 1068 108 AU # Scheduled install day/time: Every

day at 5:00

2008-06-18 08:51:32:598 1068 108 AU # Auto-install minor updates: Yes

(Policy)

2008-06-18 08:51:32:598 1068 108 AU # Will interact with non-admins

(Non-admins are elevated)

2008-06-18 08:51:32:598 1068 108 AU Setting AU scheduled install time to

2008-06-19 04:00:00

2008-06-18 08:51:33:114 1068 108 Report *********** Report: Initializing

static reporting data ***********

2008-06-18 08:51:33:114 1068 108 Report * OS Version = 5.1.2600.2.0.65792

2008-06-18 08:51:33:145 1068 108 Report * Computer Brand = Dell Computer

Corporation

2008-06-18 08:51:33:145 1068 108 Report * Computer Model = OptiPlex SX270

2008-06-18 08:51:33:145 1068 108 Report * Bios Revision = A06

2008-06-18 08:51:33:145 1068 108 Report * Bios Name = Phoenix ROM BIOS

PLUS Version 1.10 A06

2008-06-18 08:51:33:145 1068 108 Report * Bios Release Date =

2004-09-29T00:00:00

2008-06-18 08:51:33:145 1068 108 Report * Locale ID = 1033

2008-06-18 08:51:33:223 1068 108 AU AU finished delayed initialization

2008-06-18 08:51:33:223 1068 108 AU #############

2008-06-18 08:51:33:223 1068 108 AU ## START ## AU: Search for updates

2008-06-18 08:51:33:223 1068 108 AU #########

2008-06-18 08:51:33:223 1068 108 AU <<## SUBMITTED ## AU: Search for updates

[CallId = {2311F1DA-EA12-4B63-89F9-681032EE8496}]

2008-06-18 08:51:33:238 1068 e68 Agent *************

2008-06-18 08:51:33:238 1068 e68 Agent ** START ** Agent: Finding updates

[CallerId = AutomaticUpdates]

2008-06-18 08:51:33:238 1068 e68 Agent *********

2008-06-18 08:51:33:238 1068 e68 Agent * Online = No Ignore download

priority = No

2008-06-18 08:51:33:238 1068 e68 Agent * Criteria = "IsHidden=0 and

IsInstalled=0 and DeploymentAction='Installation' and IsAssigned=1 or

IsHidden=0 and IsPresent=1 and DeploymentAction='Uninstallation' and

IsAssigned=1 or IsHidden=0 and IsInstalled=1 and

DeploymentAction='Installation' and IsAssigned=1 and RebootRequired=1 or

IsHidden=0 and IsInstalled=0 and DeploymentAction='Uninstallation' and

IsAssigned=1 and RebootRequired=1"

2008-06-18 08:51:33:238 1068 e68 Agent * ServiceID =

{3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}

2008-06-18 08:51:33:363 1068 e68 Agent * Found 0 updates and 0 categories

in search evaluated appl. rules of 0 out of 0 deployed entities

2008-06-18 08:51:33:363 1068 e68 Agent *********

2008-06-18 08:51:33:363 1068 e68 Agent ** END ** Agent: Finding updates

[CallerId = AutomaticUpdates]

2008-06-18 08:51:33:363 1068 e68 Agent *************

2008-06-18 08:51:33:363 1068 e84 AU >>## RESUMED ## AU: Search for updates

[CallId = {2311F1DA-EA12-4B63-89F9-681032EE8496}]

2008-06-18 08:51:33:363 1068 e84 AU # 0 updates detected

2008-06-18 08:51:33:363 1068 e84 AU #########

2008-06-18 08:51:33:363 1068 e84 AU ## END ## AU: Search for updates

[CallId = {2311F1DA-EA12-4B63-89F9-681032EE8496}]

2008-06-18 08:51:33:363 1068 e84 AU #############

2008-06-18 08:51:33:363 1068 e84 AU Setting AU scheduled install time to

2008-06-19 04:00:00

2008-06-18 08:51:38:204 1068 e68 Report REPORT EVENT:

{87F6C986-EEDB-45C7-8DBD-63396724C451} 2008-06-18

08:51:32:598+0100 1 202 102 {00000000-0000-0000-0000-000000000000} 0 0 AutomaticUpdates Success Content Install Reboot completed.

2008-06-18 08:52:17:379 1068 55c AU Triggering AU detection through

DetectNow API

2008-06-18 08:52:17:379 1068 55c AU Triggering Online detection

(non-interactive)

2008-06-18 08:52:17:379 1068 108 AU #############

2008-06-18 08:52:17:379 1068 108 AU ## START ## AU: Search for updates

2008-06-18 08:52:17:379 1068 108 AU #########

2008-06-18 08:52:17:379 1068 108 AU <<## SUBMITTED ## AU: Search for updates

[CallId = {381FCB21-D225-4302-9FD0-7212CB5DD64F}]

2008-06-18 08:52:17:379 1068 e68 Agent *************

2008-06-18 08:52:17:379 1068 e68 Agent ** START ** Agent: Finding updates

[CallerId = AutomaticUpdates]

2008-06-18 08:52:17:379 1068 e68 Agent *********

2008-06-18 08:52:17:379 1068 e68 Agent * Online = Yes Ignore download

priority = No

2008-06-18 08:52:17:379 1068 e68 Agent * Criteria = "IsHidden=0 and

IsInstalled=0 and DeploymentAction='Installation' and IsAssigned=1 or

IsHidden=0 and IsPresent=1 and DeploymentAction='Uninstallation' and

IsAssigned=1 or IsHidden=0 and IsInstalled=1 and

DeploymentAction='Installation' and IsAssigned=1 and RebootRequired=1 or

IsHidden=0 and IsInstalled=0 and DeploymentAction='Uninstallation' and

IsAssigned=1 and RebootRequired=1"

2008-06-18 08:52:17:379 1068 e68 Agent * ServiceID =

{3DA21691-E39D-4DA6-8A4B-B43877BCB1B7}

2008-06-18 08:52:17:754 1068 e68 Misc Validating signature for

C:\WINDOWS\SoftwareDistribution\SelfUpdate\Default\wuident.cab:

2008-06-18 08:52:17:816 1068 e68 Misc Microsoft signed: Yes

2008-06-18 08:52:17:910 1068 e68 Misc Validating signature for

C:\WINDOWS\SoftwareDistribution\SelfUpdate\Default\wsus3setup.cab:

2008-06-18 08:52:17:925 1068 e68 Misc Microsoft signed: Yes

2008-06-18 08:52:17:925 1068 e68 Setup *********** Setup: Checking whether

self-update is required ***********

2008-06-18 08:52:17:925 1068 e68 Setup * Inf file:

C:\WINDOWS\SoftwareDistribution\SelfUpdate\Default\wsus3setup.inf

2008-06-18 08:52:17:957 1068 e68 Setup Update NOT required for

C:\WINDOWS\system32\cdm.dll: target version = 7.1.6001.65, required version =

7.1.6001.65