Advertised TS or software distribution never starts
Hi everyone, I got a pretty annoying bug. None of my advertised task sequences nor advertised distributed software are starting. I'm able to push the config client installation without any problem, so I tried uninstalling it and installing it. I've tried basic troubleshooting like rebooting client and server, making sure that all the network share are accesible, that the network account is correctly configured and that the computer is still active in the collection. Here's my CAS.log : <![LOG[Location update from LS for content MON00016.6 and location request {490171B6-083D-4A94-BCBD-C9DFA4ACACC2}]LOG]!><time="09:31:28.712+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:593"> <![LOG[Download location found 0 - http://%ServerName%/SMS_DP_SMSPKGE$/MON00016/]LOG]!><time="09:31:28.712+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:601"> <![LOG[Download location found 1 - \\%ServerName%\SMSPKGE$\MON00016\]LOG]!><time="09:31:28.712+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:601"> <![LOG[Matching DP Location found 0 - \\%ServerName%\SMSPKGE$\MON00016\]LOG]!><time="09:31:28.712+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:631"> <![LOG[Location update from LS for content MON00014.4 and location request {26229AD4-D984-4921-92D2-16DFD75FF3B0}]LOG]!><time="09:31:28.821+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:593"> <![LOG[Download location found 0 - http://%ServerName%/SMS_DP_SMSPKGE$/MON00014/]LOG]!><time="09:31:28.821+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:601"> <![LOG[Download location found 1 - \\%ServerName%\SMSPKGE$\MON00014\]LOG]!><time="09:31:28.821+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:601"> <![LOG[Matching DP Location found 0 - \\%ServerName%\SMSPKGE$\MON00014\]LOG]!><time="09:31:28.821+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:631"> <![LOG[Location update from LS for content MON00012.8 and location request {7482B8F4-163F-4708-98B0-58CD7B4A8233}]LOG]!><time="09:31:28.884+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:593"> <![LOG[Download location found 0 - http://%ServerName%/SMS_DP_SMSPKGE$/MON00012/]LOG]!><time="09:31:28.884+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:601"> <![LOG[Download location found 1 - \\%ServerName%\SMSPKGE$\MON00012\]LOG]!><time="09:31:28.884+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:601"> <![LOG[Download location found 2 - \\%ServerName%\SMSPXEIMAGES$\SMSPKG\MON00012\]LOG]!><time="09:31:28.884+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:601"> <![LOG[Matching DP Location found 0 - \\%ServerName%\SMSPKGE$\MON00012\]LOG]!><time="09:31:28.884+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:631"> <![LOG[Matching DP Location found 1 - \\%ServerName%\SMSPXEIMAGES$\SMSPKG\MON00012\]LOG]!><time="09:31:28.884+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:631"> <![LOG[Location update from LS for content MON0001C.8 and location request {F0C1903C-991C-4F09-91D3-F571CDA10E9C}]LOG]!><time="09:31:28.978+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:593"> <![LOG[Download location found 0 - http://%ServerName%/SMS_DP_SMSPKGE$/MON0001C/]LOG]!><time="09:31:28.978+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:601"> <![LOG[Download location found 1 - \\%ServerName%\SMSPKGE$\MON0001C\]LOG]!><time="09:31:28.978+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:601"> <![LOG[Download location found 2 - \\%ServerName%\SMSPXEIMAGES$\SMSPKG\MON0001C\]LOG]!><time="09:31:28.978+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:601"> <![LOG[Matching DP Location found 0 - \\%ServerName%\SMSPKGE$\MON0001C\]LOG]!><time="09:31:28.978+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:631"> <![LOG[Matching DP Location found 1 - \\%ServerName%\SMSPXEIMAGES$\SMSPKG\MON0001C\]LOG]!><time="09:31:28.978+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="3552" file="locationcontentrequest.cpp:631"> <![LOG[Location update from LS for content MON0000B.4 and location request {E0442DC6-470F-49D6-AA1A-A6767E69350C}]LOG]!><time="09:31:29.150+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:593"> <![LOG[Download location found 0 - http://%ServerName%/SMS_DP_SMSPKGE$/MON0000B/]LOG]!><time="09:31:29.150+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:601"> <![LOG[Download location found 1 - \\%ServerName%\SMSPKGE$\MON0000B\]LOG]!><time="09:31:29.150+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:601"> <![LOG[Matching DP Location found 0 - \\%ServerName%\SMSPKGE$\MON0000B\]LOG]!><time="09:31:29.150+240" date="07-19-2011" component="ContentAccess" context="" type="1" thread="1096" file="locationcontentrequest.cpp:631"> Here's my CcmExec.log : <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719133128.603000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 3552; }; ]LOG]!><time="09:31:28.603+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="3552" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719133128.743000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 1096; }; ]LOG]!><time="09:31:28.743+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="1096" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719133128.790000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 3740; }; ]LOG]!><time="09:31:28.790+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="3740" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719133128.884000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 3740; }; ]LOG]!><time="09:31:28.884+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="3740" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719133128.962000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 1096; }; ]LOG]!><time="09:31:28.962+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="1096" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719133428.570000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 3740; }; ]LOG]!><time="09:34:28.570+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="3740" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719133729.303000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 3864; }; ]LOG]!><time="09:37:29.303+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="3864" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719134428.832000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 1076; }; ]LOG]!><time="09:44:28.832+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="1076" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719134729.565000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 1076; }; ]LOG]!><time="09:47:29.565+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="1076" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719135429.094000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 3536; }; ]LOG]!><time="09:54:29.094+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="3536" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719135729.796000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 3388; }; ]LOG]!><time="09:57:29.796+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="3388" file="event.cpp:525"> <![LOG[Raising event: instance of CCM_CcmHttp_Status { ClientID = "GUID:BA6AFAFF-B22E-4AB1-AB44-E0568D430A00"; DateTime = "20110719140429.340000+000"; HostName = "%ServerName%"; HRESULT = "0x00000000"; ProcessID = 520; StatusCode = 0; ThreadID = 2120; }; ]LOG]!><time="10:04:29.340+240" date="07-19-2011" component="CcmExec" context="" type="1" thread="2120" file="event.cpp:525"> Smsts.log simply doesn't react unless I manually start the Task Manager Service on the client, and it just shows nothing. Simply ask if you want any other log. My guess is that, as I saw with similar problems on the internet, something is wrong with BITS. But why is it still downloading when I specify to run the TS directly from the DP? I hope some of you guys will be able to find what's wrong with this! Thank you!
July 19th, 2011 10:26am

Execmgr.log is the log to review.Jason | http://myitforum.com/cs2/blogs/jsandys | Twitter @JasonSandys
Free Windows Admin Tool Kit Click here and download it now
July 19th, 2011 11:18am

Here's what I got in Execmgr.log <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="09:31:28.728+240" date="07-19-2011" component="execmgr" context="" type="3" thread="3552" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="09:31:28.837+240" date="07-19-2011" component="execmgr" context="" type="3" thread="1096" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="09:31:28.900+240" date="07-19-2011" component="execmgr" context="" type="3" thread="1096" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="09:31:28.978+240" date="07-19-2011" component="execmgr" context="" type="3" thread="3552" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="09:31:29.150+240" date="07-19-2011" component="execmgr" context="" type="3" thread="1096" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="10:31:29.955+240" date="07-19-2011" component="execmgr" context="" type="3" thread="1052" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="10:31:30.080+240" date="07-19-2011" component="execmgr" context="" type="3" thread="1052" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="10:31:30.126+240" date="07-19-2011" component="execmgr" context="" type="3" thread="2232" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="10:31:30.236+240" date="07-19-2011" component="execmgr" context="" type="3" thread="2232" file="execreqmgr.cpp:5036"> <![LOG[OnContentAvailable invalid request GUID handle]LOG]!><time="10:31:30.283+240" date="07-19-2011" component="execmgr" context="" type="3" thread="2232" file="execreqmgr.cpp:5036"> <![LOG[Policy arrived for child program CCMCertFix.exe]LOG]!><time="10:54:36.784+240" date="07-19-2011" component="execmgr" context="" type="1" thread="2092" file="execreqmgr.cpp:6430"> <![LOG[Policy is updated for Program: *, Package: MON00027, Advert: MON2008D]LOG]!><time="10:54:36.940+240" date="07-19-2011" component="execmgr" context="" type="1" thread="2744" file="execreqmgr.cpp:6711"> <![LOG[Policy is updated for Program: *, Package: MON00027, Advert: MON2008D]LOG]!><time="11:04:34.694+240" date="07-19-2011" component="execmgr" context="" type="1" thread="940" file="execreqmgr.cpp:6711"> What "OnContentAvailable invalid request GUID handle" is about?
July 19th, 2011 11:33am

Hi, Please check if the file is available at distribution point (OnContentAvailable invalid request GUID handle). If not, please replace the file at the source and update the distribution point. Regards, Sabrina This posting is provided "AS IS" with no warranties or guarantees, and confers no rights. |Please remember to click Mark as Answer on the post that helps you, and to click Unmark as Answer if a marked post does not actually answer your question. This can be beneficial to other community members reading the thread.
Free Windows Admin Tool Kit Click here and download it now
July 21st, 2011 3:26am

This topic is archived. No further replies will be accepted.

Other recent topics Other recent topics