Step Install updates timeout during OSD

Posted by

Issue: 

Windows Updates won’t install during OSD, the Install Updates task will eventually fail after a time out (1 hour). I’m not sure if it’s ConfigMgr upgrade related but we had this issue after upgrading to 1806 HF. I have seen similar tweets where others seen the same behavior after upgrading.

Logfiles:

SMTSTS:

Waiting for RefreshUpdates complete notification from Updates Deployment Agent    InstallSWUpdate    05/09/2018 08:25:21    3776 (0x0EC0)
FALSE, HRESULT=800705b4 (installswupdate.cpp,1359)    InstallSWUpdate    05/09/2018 09:25:21    3776 (0x0EC0)
Time-out expired waiting for updates refresh complete notification.    InstallSWUpdate    05/09/2018 09:25:21    3776 (0x0EC0)
WaitForRefreshUpdatesComplete(spInstall), HRESULT=800705b4 (installswupdate.cpp,1492)    InstallSWUpdate    05/09/2018 09:25:21    3776 (0x0EC0)
RefreshUpdates(bForceOnlineScan), HRESULT=800705b4 (installswupdate.cpp,1001)    InstallSWUpdate    05/09/2018 09:25:21    3776 (0x0EC0)
InstallUpdates(pInstallUpdate, tType, sJobID, sActiveRequestHandle), HRESULT=800705b4 (main.cpp,248)    InstallSWUpdate    05/09/2018 09:25:21    3776 (0x0EC0)

WUHandler:

Restarting WU Agent service…    WUAHandler    05/09/2018 08:27:36    1392 (0x0570)
Stopped the service ‘wuauserv’ successfully    WUAHandler    05/09/2018 08:27:36    1392 (0x0570)
Waiting for 30 secs for policy to take effect on WU Agent.    WUAHandler    05/09/2018 08:27:37    1392 (0x0570)
Added Update Source ({C8337872-4E0A-4554-A5E4-CC19EF8F06C5}) of content type: 2    WUAHandler    05/09/2018 08:28:07    1392 (0x0570)
CWUAHandler – Scan(), old SupersedenceMode=0, new SupersedenceMode=1. Need update and save to SourceManager.    WUAHandler    05/09/2018 08:28:07    1392 (0x0570)
Modified Update Source ({C8337872-4E0A-4554-A5E4-CC19EF8F06C5}) to new SupersedenceMode: 1    WUAHandler    05/09/2018 08:28:07    1392 (0x0570)
Scan results will include all superseded updates.    WUAHandler    05/09/2018 08:28:07    1392 (0x0570)
Search Criteria is (DeploymentAction=* AND Type=’Software’) OR (DeploymentAction=* AND Type=’Driver’)    WUAHandler    05/09/2018 08:28:07    1392 (0x0570)
Async searching of updates using WUAgent started.    WUAHandler    05/09/2018 08:28:07    1392 (0x0570)
Async searching completed.    WUAHandler    05/09/2018 08:28:59    676 (0x02A4)
Successfully completed scan.    WUAHandler    05/09/2018 08:29:00    3956 (0x0F74)
Its a WSUS Update Source type ({C8337872-4E0A-4554-A5E4-CC19EF8F06C5}), adding it.    WUAHandler    05/09/2018 08:29:00    3892 (0x0F34)
Not RS3+, this device is SCCM managed.    WUAHandler    05/09/2018 08:29:00    536 (0x0218)
SourceManager::GetIsWUfBEnabled – There is no Windows Update for Business settings assignment. Windows Update for Business is not enabled through ConfigMgr    WUAHandler    05/09/2018 08:29:00    536 (0x0218)
Existing WUA Managed server was already set (https://AXXXXX.X.XXX:8531), skipping Group Policy registration.    WUAHandler    05/09/2018 08:29:00    3892 (0x0F34)
Added Update Source ({C8337872-4E0A-4554-A5E4-CC19EF8F06C5}) of content type: 2    WUAHandler    05/09/2018 08:29:00    3892 (0x0F34)
Scan results will include all superseded updates.    WUAHandler    05/09/2018 08:29:00    3892 (0x0F34)
Search Criteria is (DeploymentAction=* AND Type=’Software’) OR (DeploymentAction=* AND Type=’Driver’)    WUAHandler    05/09/2018 08:29:00    3892 (0x0F34)
Async searching of updates using WUAgent started.    WUAHandler    05/09/2018 08:29:00    3892 (0x0F34)
Async searching completed.    WUAHandler    05/09/2018 08:29:04    2912 (0x0B60)
Successfully completed scan.    WUAHandler    05/09/2018 08:29:05    3892 (0x0F34)

ScanAgent

ScanJob({3696A025-8B64-4399-B2BA-74A4C7FE6202}): CScanJobManager::OnScanComplete -ScanJob is completed.    ScanAgent    05/09/2018 08:29:05    1380 (0x0564)
ScanJob({3696A025-8B64-4399-B2BA-74A4C7FE6202}): CScanJobManager::OnScanComplete – Reporting Scan request complete to clients…    ScanAgent    05/09/2018 08:29:05    1380 (0x0564)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:05    1380 (0x0564)
– – Calling back to client on Scan request complete…    ScanAgent    05/09/2018 08:29:05    1380 (0x0564)
ScanJob({8E7CEE95-0A95-46D9-9EFA-2302A02530B1}): CScanJobManager::OnScanComplete -ScanJob is completed.    ScanAgent    05/09/2018 08:29:06    1256 (0x04E8)
ScanJob({8E7CEE95-0A95-46D9-9EFA-2302A02530B1}): CScanJobManager::OnScanComplete – Reporting Scan request complete to clients…    ScanAgent    05/09/2018 08:29:06    1256 (0x04E8)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
– – Calling back to client on Scan request complete…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
ScanJob({03761DEE-6D2A-4A0C-883E-B529837D13DE}): CScanJobManager::OnScanComplete -ScanJob is completed.    ScanAgent    05/09/2018 08:29:06    3956 (0x0F74)
ScanJob({03761DEE-6D2A-4A0C-883E-B529837D13DE}): CScanJobManager::OnScanComplete – Reporting Scan request complete to clients…    ScanAgent    05/09/2018 08:29:06    3956 (0x0F74)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
– – Calling back to client on Scan request complete…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
ScanJob({4BE9D76A-DA7B-45E5-8BF8-DEAEC2ABC190}): CScanJobManager::OnScanComplete -ScanJob is completed.    ScanAgent    05/09/2018 08:29:06    1220 (0x04C4)
ScanJob({4BE9D76A-DA7B-45E5-8BF8-DEAEC2ABC190}): CScanJobManager::OnScanComplete – Reporting Scan request complete to clients…    ScanAgent    05/09/2018 08:29:06    1220 (0x04C4)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
– – Calling back to client on Scan request complete…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
ScanJob({FD11A867-F580-45CE-B166-6EED587C0505}): CScanJobManager::OnScanComplete -ScanJob is completed.    ScanAgent    05/09/2018 08:29:06    3644 (0x0E3C)
ScanJob({FD11A867-F580-45CE-B166-6EED587C0505}): CScanJobManager::OnScanComplete – Reporting Scan request complete to clients…    ScanAgent    05/09/2018 08:29:06    3644 (0x0E3C)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
– – Calling back to client on Scan request complete…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
ScanJob({C6F3BABA-66E2-4F52-A87A-0F3DC67CC94B}): CScanJobManager::OnScanComplete -ScanJob is completed.    ScanAgent    05/09/2018 08:29:06    1392 (0x0570)
ScanJob({C6F3BABA-66E2-4F52-A87A-0F3DC67CC94B}): CScanJobManager::OnScanComplete – Reporting Scan request complete to clients…    ScanAgent    05/09/2018 08:29:06    1392 (0x0570)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
– – Calling back to client on Scan request complete…    ScanAgent    05/09/2018 08:29:06    1380 (0x0564)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    3344 (0x0D10)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    1220 (0x04C4)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:06    4032 (0x0FC0)
– – -Evaluating Update Status…    ScanAgent    05/09/2018 08:29:07    3920 (0x0F50)

UpdateHandler:

Successfully initiated scan.    UpdatesHandler    05/09/2018 08:28:08    3920 (0x0F50)
Successfully initiated scan.    UpdatesHandler    05/09/2018 08:28:08    1384 (0x0568)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:00    3876 (0x0F24)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    3956 (0x0F74)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    3876 (0x0F24)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    3344 (0x0D10)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    3892 (0x0F34)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    3088 (0x0C10)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    3852 (0x0F0C)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    1384 (0x0568)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    4036 (0x0FC4)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    3920 (0x0F50)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:05    1380 (0x0564)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:06    1380 (0x0564)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:06    1380 (0x0564)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:06    1380 (0x0564)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:06    1380 (0x0564)
Updates scan completion received, result = 0x0.    UpdatesHandler    05/09/2018 08:29:06    1380 (0x0564)

UpdatesDeployment:

Raising client SDK event for class CCM_SoftwareUpdate, instance CCM_SoftwareUpdate.UpdateID=”Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_ec23bd30-6b50-4935-9208-d2314db5c761″, actionType 12l, value NULL, user NULL, session 4294967295l, level 0l, verbosity 30l    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Update (Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_ec23bd30-6b50-4935-9208-d2314db5c761) added to the targeted list of deployment ({7331B19C-0889-41BE-80AF-CA0965758D8E})    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Raising client SDK event for class CCM_SoftwareUpdate, instance CCM_SoftwareUpdate.UpdateID=”Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_9ae38a26-59a8-44d7-8524-fd750a9092b8″, actionType 12l, value NULL, user NULL, session 4294967295l, level 0l, verbosity 30l    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Update (Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_9ae38a26-59a8-44d7-8524-fd750a9092b8) added to the targeted list of deployment ({7331B19C-0889-41BE-80AF-CA0965758D8E})    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Raising client SDK event for class CCM_SoftwareUpdate, instance CCM_SoftwareUpdate.UpdateID=”Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_3691827b-92e2-4f18-acfa-8e42b48119e7″, actionType 12l, value NULL, user NULL, session 4294967295l, level 0l, verbosity 30l    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Update (Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_3691827b-92e2-4f18-acfa-8e42b48119e7) added to the targeted list of deployment ({7331B19C-0889-41BE-80AF-CA0965758D8E})    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Raising client SDK event for class CCM_SoftwareUpdate, instance CCM_SoftwareUpdate.UpdateID=”Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_3f23889e-6a30-41ed-981b-c61eeca84d01″, actionType 12l, value NULL, user NULL, session 4294967295l, level 0l, verbosity 30l    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Update (Site_C8337872-4E0A-4554-A5E4-CC19EF8F06C5/SUM_3f23889e-6a30-41ed-981b-c61eeca84d01) added to the targeted list of deployment ({7331B19C-0889-41BE-80AF-CA0965758D8E})    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
Trigger detect – no further action needed.    UpdatesDeploymentAgent    05/09/2018 08:29:08    3892 (0x0F34)
CEvalO365ManagementTask::Execute()    UpdatesDeploymentAgent    05/09/2018 08:36:56    3692 (0x0E6C)
Not RS3+, this device is SCCM managed.    UpdatesDeploymentAgent    05/09/2018 08:36:56    3692 (0x0E6C)

Cause:

I don’t know what causes this issue. We had a call open with MS but we closed it without knowing the root cause. We closed the case because it was “solved” in our environment.

Solution:

I created a new Software Update Deployment and deployed it again to the same (OSD) collection. After doing this the Install Update step during OSD is working again.

Link to technet: https://social.technet.microsoft.com/Forums/en-US/aa6a7286-32ea-499b-bec1-7ffe459ba472/install-updates-timeout-after-upgrade-sccm-1806?forum=ConfigMgrCBOSD

Leave a Reply

Your email address will not be published. Required fields are marked *

This site uses Akismet to reduce spam. Learn how your comment data is processed.