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.