SharePoint.Administration.SPTimerJobInvokeInternal.Invoke

 Process                                  TID    Area                           Category                       Ev
 Entering monitored scope (Timer Job job-solution-resource-usage-log)
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-log). Execution Time=3.66002365468559
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=2.82228409233393
 Entering monitored scope (Timer Job Search Health Monitoring - Trace Events)
 Entering monitored scope (Timer Job job-immediate-alerts)
 Leaving Monitored Scope (Timer Job Search Health Monitoring - Trace Events). Execution Time=3.58303227258762
 Leaving Monitored Scope (Timer Job job-immediate-alerts). Execution Time=7.83808932320176
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=2.56821253141065
 wsstracing.exe (0x098C)                  0x1394 SharePoint Foundation          Unified Logging Service        b9wt High     Log retention limit reached.  Log file 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-2
 wsstracing.exe (0x098C)                  0x1394 SharePoint Foundation          Tracing Controller Service     8096 Information Usage log retention limit reached.  Some old
 Entering monitored scope (Timer Job VariationsSpawnSites)
 OWSTIMER.EXE (0x0A0C)                    0x1C78 Web Content Management         Site Management                c07h High     SpawnVariationSitesJob has started
 OWSTIMER.EXE (0x0A0C)                    0x1C78 Web Content Management         Site Management                c07i High     SpawnVariationSitesJob has finished. Time Spent: 00:00:00.0020002
 Entering monitored scope (Timer Job VariationsSpawnSites)
 OWSTIMER.EXE (0x0A0C)                    0x0C8C Web Content Management         Site Management                c07h High     SpawnVariationSitesJob has started
 OWSTIMER.EXE (0x0A0C)                    0x0C8C Web Content Management         Site Management                c07i High     SpawnVariationSitesJob has finished. Time Spent: 00:00:00.0010001
 Leaving Monitored Scope (Timer Job VariationsSpawnSites). Execution Time=6.10431672348142
 Leaving Monitored Scope (Timer Job VariationsSpawnSites). Execution Time=3.00193065056251
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x11FC Web Content Management         Site Management                c07h High     VariationCreateSites has started
 OWSTIMER.EXE (0x0A0C)                    0x11FC Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00.0010001
 Entering monitored scope (Timer Job job-workflow)
 Leaving Monitored Scope (Timer Job VariationsCreateSite). Execution Time=3.53280456140943
 Leaving Monitored Scope (Timer Job job-workflow). Execution Time=12.3054226130288
 Entering monitored scope (Timer Job job-immediate-alerts)
 Leaving Monitored Scope (Timer Job job-immediate-alerts). Execution Time=9.14547631635099
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Entering monitored scope (Timer Job job-immediate-alerts)
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x1FCC Web Content Management         Site Management                c07h High     VariationCreateSites has started
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=12.8212648730852
 OWSTIMER.EXE (0x0A0C)                    0x1FCC Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00.0030003
 Leaving Monitored Scope (Timer Job VariationsCreateSite). Execution Time=7.3251800681777
 Leaving Monitored Scope (Timer Job job-immediate-alerts). Execution Time=19.0817641145368
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.93981620323965
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.91048615291662
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.87272371312571
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.00837519586974
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.87529009252898
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=3.57569976000686
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=3.03822658783727
 Topology cache updated. (AppDomain: /LM/W3SVC/10
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=3.86790038635009
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.79405391889801
 Entering monitored scope (Timer Job job-application-server-admin-service)
 OWSTIMER.EXE (0x0A0C)                    0x1C78 SharePoint Server Search       Administration                 dkd5 High     synchronizing search service instance
 OWSTIMER.EXE (0x0A0C)                    0x1C78 SharePoint Server Search       Administration                 eff0 High     synchronizing search data access service instance
 Search application 'Search Service Application': Provision start addresses in default content source.
 Leaving Monitored Scope (Timer Job job-application-server-admin-service). Execution Time=320.824555704731
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.89398799960991
 Entering monitored scope (Timer Job job-application-server)
 Leaving Monitored Scope (Timer Job job-application-server). Execution Time=1.25019339501932
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=2.00690869335359
 Entering monitored scope (Timer Job Health Statistics Updating)
 Updating SPPersistedObject SearchServiceApplicationMonitoring Name=Monitoring_7F19A5D194F942e6A9856FCFD6EE6F63. Version: 370793 Ensure: False, HashCode: 56209713, Id: 271e0a48-8c75-4029-befd-1444fed8810f, Stack:    at Microsoft.SharePoint.Administration.SPPersistedObject.BaseUpdate()     at Microsoft.Office.Server.Search.Monitoring.TraceDiagnosticsProvider.UpdateServiceApplicationHealthStats()     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.97464563799825
 Leaving Monitored Scope (Timer Job Health Statistics Updating). Execution Time=26.7842019549945
 Entering monitored scope (Timer Job job-timer-locks)
 Leaving Monitored Scope (Timer Job job-timer-locks). Execution Time=4.7555010342509
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=13.9955667628937
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.9354166956912
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.86319144677072
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.94091608012676
 Entering monitored scope (Timer Job Search Health Monitoring - Trace Events)
 Leaving Monitored Scope (Timer Job Search Health Monitoring - Trace Events). Execution Time=4.06551160040153
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.89838750715837
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.85805868796419
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.91085277854565
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.91818529112641
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.8716238362386
 Entering monitored scope (Timer Job SchedulingApproval)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=8.69269366448916
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=3.36159039264872
 Topology cache updated. (AppDomain: /LM/W3SVC/1059487122/ROOT-1-129764516568605166)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=5.75932200655673
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.92881743436851
 Entering monitored scope (Timer Job job-application-server-admin-service)
 OWSTIMER.EXE (0x0A0C)                    0x2358 SharePoint Server Search       Administration                 dkd5 High     synchronizing search service instance
 OWSTIMER.EXE (0x0A0C)                    0x2358 SharePoint Server Search       Administration                 eff0 High     synchronizing search data access service instance
 Search application 'Search Service Application': Provision start addresses in default content source.
 Leaving Monitored Scope (Timer Job job-application-server-admin-service). Execution Time=306.868584509774
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.99884292951476
 Entering monitored scope (Timer Job job-application-server)
 Leaving Monitored Scope (Timer Job job-application-server). Execution Time=1.45587037290959
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.87309033875475
 Entering monitored scope (Timer Job Health Statistics Updating)
 Updating SPPersistedObject SearchServiceApplicationMonitoring Name=Monitoring_7F19A5D194F942e6A9856FCFD6EE6F63. Version: 370795 Ensure: False, HashCode: 49549649, Id: 271e0a48-8c75-4029-befd-1444fed8810f, Stack:    at Microsoft.SharePoint.Administration.SPPersistedObject.BaseUpdate()     at Microsoft.Office.Server.Search.Monitoring.TraceDiagnosticsProvider.UpdateServiceApplicationHealthStats()     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job Health Statistics Updating). Execution Time=36.7003253435832
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=31.1650115963686
 Entering monitored scope (Timer Job VariationsPropagatePage)
 OWSTIMER.EXE (0x0A0C)                    0x21A4 Web Content Management         Site Management                c07h High     PropogateVariationPageJob has started
 OWSTIMER.EXE (0x0A0C)                    0x21A4 Web Content Management         Site Management                c07i High     PropogateVariationPageJob has finished. Time Spent: 00:00:00.0010001
 Leaving Monitored Scope (Timer Job VariationsPropagatePage). Execution Time=2.11323012577459
 Entering monitored scope (Timer Job HiddenListFullSyncTimerJob)
 Hidden List full sync timer job starts.
 OWSTIMER.EXE (0x0A0C)                    0x1694 SharePoint Foundation          Database                       4ohp High     Enumerating all sites in SPContentDatabase Name=WSS_Content_a90190920f3248359d640f42420f68ec.
 Site Enumeration Stack:    at Microsoft.SharePoint.Administration.SPSiteCollection.get_Item(Int32 index)     at Microsoft.SharePoint.Taxonomy.HiddenListFullSyncJobDefinition.Execute(SPContentDatabase contentDatabase, SPJobState jobState)     at Microsoft.SharePoint.Administration.SPContentDatabaseJobDefinition.Execute(SPJobState jobState)     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 WcfSendRequest: RemoteAddress: 'http://itd-018:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'Microsoft.SharePoint.Taxonomy.IMetadataWebServiceApplication' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IDataAccessReadOnly/GetChangesForFullListSync' MessageId: 'urn:uuid:089bc76b-cd61-4765-b47c-cb9840b4d318'
 WcfReceiveRequest: LocalAddress: 'http://itd-018...ae:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IDataAccessReadOnly/GetChangesForFullListSync' MessageId: 'urn:uuid:089bc76b-cd61-4765-b47c-cb9840b4d318'
 Entering monitored scope (ExecuteWcfServerOperation)
 MetadataWebServiceApplication.GetChangesForFullListSync called on 'Managed Metadata Service' starting.
 MetadataWebServiceApplication.GetChangesForFullListSync called on 'Managed Metadata Service' completed.
 Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=6.78220751157254
 Hidden List full sync timer job ends.
 Leaving Monitored Scope (Timer Job HiddenListFullSyncTimerJob). Execution Time=24.7244991710595
 Entering monitored scope (Timer Job job-timer-locks)
 Leaving Monitored Scope (Timer Job job-timer-locks). Execution Time=4.18503155546789
 Entering monitored scope (Timer Job SchedulingApproval)
 Entering monitored scope (Timer Job UpdateHiddenListJobDefinition)
 OWSTIMER.EXE (0x0A0C)                    0x1DC0 SharePoint Foundation          Database                       4ohp High     Enumerating all sites in SPWebApplication Name=POIDeploy.
 Site Enumeration Stack:    at Microsoft.SharePoint.Administration.SPSiteCollection.get_Item(Int32 index)     at Microsoft.SharePoint.Taxonomy.UpdateHiddenListJobDefinition.Execute(Guid targetInstanceId)     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Verified that the metadata hub timer job already exists for this farm.
 Hidden list full sync timer job is being created and associated with the web application POIDeploy.
 Hidden list full sync timer job was not created and associated with the web application POIDeploy.  jobDefinition was already set.
 OWSTIMER.EXE (0x0A0C)                    0x1DC0 SharePoint Foundation          Database                       4ohp High     Enumerating all sites in SPWebApplication Name=POIDeploy.
 Site Enumeration Stack:    at Microsoft.SharePoint.Administration.SPSiteCollection.get_Count()     at Microsoft.SharePoint.Taxonomy.UpdateHiddenListJobDefinition.Execute(Guid targetInstanceId)     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=4.24662466114626
 OWSTIMER.EXE (0x0A0C)                    0x1DC0 SharePoint Foundation          Database                       4ohp High     Enumerating all sites in SPWebApplication Name=POIDeploy.
 Site Enumeration Stack:    at Microsoft.SharePoint.Administration.SPSiteCollection.get_Item(Int32 index)     at Microsoft.SharePoint.Taxonomy.UpdateHiddenListJobDefinition.Execute(Guid targetInstanceId)     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Entering monitored scope (Timer Job SchedulingUnpublish)
 WcfSendRequest: RemoteAddress: 'http://itd-018:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'Microsoft.SharePoint.Taxonomy.IMetadataWebServiceApplication' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IMetadataWebServiceApplication/GetServiceSettings' MessageId: 'urn:uuid:d2646759-2f6d-4a47-a9b9-80752260d507'
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.9808782736919
 WcfReceiveRequest: LocalAddress: 'http://itd-018...ae:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IMetadataWebServiceApplication/GetServiceSettings' MessageId: 'urn:uuid:d2646759-2f6d-4a47-a9b9-80752260d507'
 Entering monitored scope (ExecuteWcfServerOperation)
 Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=3.85726824310799
 WcfSendRequest: RemoteAddress: 'http://itd-018:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'Microsoft.SharePoint.Taxonomy.IMetadataWebServiceApplication' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IDataAccessReadOnly/GetChangesForListSync' MessageId: 'urn:uuid:069835b3-6e84-4ec0-ae4b-3c5070b51228'
 WcfReceiveRequest: LocalAddress: 'http://itd-018...ae:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IDataAccessReadOnly/GetChangesForListSync' MessageId: 'urn:uuid:069835b3-6e84-4ec0-ae4b-3c5070b51228'
 Entering monitored scope (ExecuteWcfServerOperation)
 MetadataWebServiceApplication.GetChangesForListSync called on 'Managed Metadata Service' starting.
 GetChangesForListSync called on WebApp 367e99ea-1181-4c5d-98f1-c035282c33dd with time 01/01/2001 00:00:00
 MetadataWebServiceApplication.GetChangesForListSync called on 'Managed Metadata Service' completed.
 Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=2.37793382993997
 Leaving Monitored Scope (Timer Job UpdateHiddenListJobDefinition). Execution Time=34.2941613402073
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.85072617538344
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.86979070809341
 Entering monitored scope (Timer Job Search Health Monitoring - Trace Events)
 Leaving Monitored Scope (Timer Job Search Health Monitoring - Trace Events). Execution Time=3.09798656537045
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.88555561014204
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.25181461355092
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.04723751254776
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.97537888925633
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.91928516801353
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=7.22032513827286
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=6.25866611330638
 Topology cache updated. (AppDomain: /LM/W3SVC/1059487122/ROOT-1-129764516568605166)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=4.41820545553601
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.08353344982252
 Entering monitored scope (Timer Job job-application-server-admin-service)
 OWSTIMER.EXE (0x0A0C)                    0x0E58 SharePoint Server Search       Administration                 dkd5 High     synchronizing search service instance
 OWSTIMER.EXE (0x0A0C)                    0x0E58 SharePoint Server Search       Administration                 eff0 High     synchronizing search data access service instance
 Search application 'Search Service Application': Provision start addresses in default content source.
 Leaving Monitored Scope (Timer Job job-application-server-admin-service). Execution Time=310.126786475034
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.91341915794892
 Entering monitored scope (Timer Job job-application-server)
 Leaving Monitored Scope (Timer Job job-application-server). Execution Time=1.3176525107623
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=2.06996830154811
 Entering monitored scope (Timer Job SchedulingApproval)
 Entering monitored scope (Timer Job Health Statistics Updating)
 Updating SPPersistedObject SearchServiceApplicationMonitoring Name=Monitoring_7F19A5D194F942e6A9856FCFD6EE6F63. Version: 370797 Ensure: False, HashCode: 42233530, Id: 271e0a48-8c75-4029-befd-1444fed8810f, Stack:    at Microsoft.SharePoint.Administration.SPPersistedObject.BaseUpdate()     at Microsoft.Office.Server.Search.Monitoring.TraceDiagnosticsProvider.UpdateServiceApplicationHealthStats()     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=6.38148569903409
 Leaving Monitored Scope (Timer Job Health Statistics Updating). Execution Time=32.6964068488601
 Entering monitored scope (Timer Job MetadataSubscriberTimerJob)
 Content type subscriber timer job starts.
 OWSTIMER.EXE (0x0A0C)                    0x09B4 SharePoint Foundation          Database                       4ohp High     Enumerating all sites in SPContentDatabase Name=WSS_Content_25cb5ca6be114e7487e012d83af7470f.
 Site Enumeration Stack:    at Microsoft.SharePoint.Administration.SPSiteCollection.get_Names()     at Microsoft.SharePoint.Administration.SPAllSitesJobDefinition.Execute(SPContentDatabase contentDatabase, SPJobState jobState)     at Microsoft.SharePoint.Taxonomy.ContentTypeSync.Internal.SubscriberTimerJobDefinition.Execute(SPContentDatabase contentDatabase, SPJobState jobState)     at Microsoft.SharePoint.Administration.SPContentDatabaseJobDefinition.Execute(SPJobState jobState)     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Content type subscriber timer job ends.
 Leaving Monitored Scope (Timer Job MetadataSubscriberTimerJob). Execution Time=6.1244811330785
 Entering monitored scope (Timer Job job-timer-locks)
 Leaving Monitored Scope (Timer Job job-timer-locks). Execution Time=4.52452688795701
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.84412691406075
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.55009315957234
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.58675572247613
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.89215487146472
 Entering monitored scope (Timer Job Search Health Monitoring - Trace Events)
 Leaving Monitored Scope (Timer Job Search Health Monitoring - Trace Events). Execution Time=3.05325823862782
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.92551780370717
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.95888073594962
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.87272371312571
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.90315364033586
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.89508787649702
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=4.03801467822368
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=2.50918580513555
 Topology cache updated. (AppDomain: /LM/W3SVC/1059487122/ROOT-1-129764516568605166)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=3.48331010148931
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.87727793668962
 Entering monitored scope (Timer Job job-application-server-admin-service)
 OWSTIMER.EXE (0x0A0C)                    0x09B4 SharePoint Server Search       Administration                 dkd5 High     synchronizing search service instance
 OWSTIMER.EXE (0x0A0C)                    0x09B4 SharePoint Server Search       Administration                 eff0 High     synchronizing search data access service instance
 Search application 'Search Service Application': Provision start addresses in default content source.
 Leaving Monitored Scope (Timer Job job-application-server-admin-service). Execution Time=325.937516727294
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.991510416934
 Entering monitored scope (Timer Job MetadataSubscriberTimerJob)
 Content type subscriber timer job starts.
 OWSTIMER.EXE (0x0A0C)                    0x1FCC SharePoint Foundation          Database                       4ohp High     Enumerating all sites in SPContentDatabase Name=WSS_Content_d13e693dd163488cbe8d24965eb399fd.
 Site Enumeration Stack:    at Microsoft.SharePoint.Administration.SPSiteCollection.get_Names()     at Microsoft.SharePoint.Administration.SPAllSitesJobDefinition.Execute(SPContentDatabase contentDatabase, SPJobState jobState)     at Microsoft.SharePoint.Taxonomy.ContentTypeSync.Internal.SubscriberTimerJobDefinition.Execute(SPContentDatabase contentDatabase, SPJobState jobState)     at Microsoft.SharePoint.Administration.SPContentDatabaseJobDefinition.Execute(SPJobState jobState)     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Content type subscriber timer job ends.
 Leaving Monitored Scope (Timer Job MetadataSubscriberTimerJob). Execution Time=5.67169848121667
 Entering monitored scope (Timer Job job-application-server)
 Leaving Monitored Scope (Timer Job job-application-server). Execution Time=1.42874007636079
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.8668577030611
 Entering monitored scope (Timer Job Health Statistics Updating)
 Updating SPPersistedObject SearchServiceApplicationMonitoring Name=Monitoring_7F19A5D194F942e6A9856FCFD6EE6F63. Version: 370799 Ensure: False, HashCode: 47302545, Id: 271e0a48-8c75-4029-befd-1444fed8810f, Stack:    at Microsoft.SharePoint.Administration.SPPersistedObject.BaseUpdate()     at Microsoft.Office.Server.Search.Monitoring.TraceDiagnosticsProvider.UpdateServiceApplicationHealthStats()     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.93395019317504
 Leaving Monitored Scope (Timer Job Health Statistics Updating). Execution Time=33.8787745025074
 Entering monitored scope (Timer Job job-timer-locks)
 Leaving Monitored Scope (Timer Job job-timer-locks). Execution Time=14.085756667637
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=4.42040520931024
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=2.51871807149053
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.8774898463032
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.85695881107708
 Entering monitored scope (Timer Job Search Health Monitoring - Trace Events)
 Leaving Monitored Scope (Timer Job Search Health Monitoring - Trace Events). Execution Time=3.14344814337115
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x1C78 Web Content Management         Site Management                c07h High     VariationCreateSites has started
 OWSTIMER.EXE (0x0A0C)                    0x1C78 Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00.0010001
 Entering monitored scope (Timer Job job-spconnectedserviceapplication-addressesrefresh)
 Leaving Monitored Scope (Timer Job VariationsCreateSite). Execution Time=7.88465077808957
 Leaving Monitored Scope (Timer Job job-spconnectedserviceapplication-addressesrefresh). Execution Time=7.27018622382201
 Entering monitored scope (Timer Job job-usage-log-file-import)
 Begin usage service data import job.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852e High     Preparing to import '6' usage log files found with filter 'ITD-018-????????-?????.usage'.
 Starting usage log files import.
 Importing usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1357.usage'.
 Openning trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1357.usage'.
 Entering monitored scope (Timer Job Word Automation Services)
 Timer 'Word Automation Services': Begin Execute
 Timer 'Word Automation Services': Retrieving list of worker endpoints
 Timer 'Word Automation Services': Retrieving list of items, max 300
 Entering monitored scope (Timer Job job-workflow-failover)
 Leaving Monitored Scope (Timer Job job-workflow-failover). Execution Time=1.83936078088326
 Timer 'Word Automation Services': End Execute
 Leaving Monitored Scope (Timer Job Word Automation Services). Execution Time=4.53625890808622
 Processing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1357.usage'.
 Closing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1357.usage'.
 Imported usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1357.usage'.
 Importing usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1402.usage'.
 Openning trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1402.usage'.
 Processing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1402.usage'.
 Closing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1402.usage'.
 Imported usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1402.usage'.
 Importing usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1407.usage'.
 Openning trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1407.usage'.
 Processing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1407.usage'.
 Closing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1407.usage'.
 Imported usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1407.usage'.
 Importing usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1412.usage'.
 Openning trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1412.usage'.
 Processing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1412.usage'.
 Closing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1412.usage'.
 Imported usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1412.usage'.
 Importing usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1417.usage'.
 Openning trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1417.usage'.
 Processing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1417.usage'.
 Closing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1417.usage'.
 Imported usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1417.usage'.
 Importing usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1422.usage'.
 Openning trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1422.usage'.
 Processing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1422.usage'.
 Closing trace session to usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1422.usage'.
 Imported usage log file: 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1422.usage'.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852n High     Flushing usage entry cache to storage (count=960).
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           85f9 High     Calling ImportEntries method for usage definition 'Microsoft.SharePoint.Administration.SPTimerJobUsageDefinition' with '943' entries.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852u High     Called ImportEntries method for usage definition 'Microsoft.SharePoint.Administration.SPTimerJobUsageDefinition'.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           85f9 High     Calling ImportEntries method for usage definition 'Microsoft.SharePoint.Administration.SPRequestUsageDefinition' with '17' entries.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           884c High     Calling 'UsageImported' method of Usage Receiver 'Microsoft.SharePoint.Administration.SPUsageReceiverDefinition' for Usage Definition 'Microsoft.SharePoint.Administration.SPRequestUsageDefinition'.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           884d High     Instantiating usage receiver...
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           884k High     Instantiated usage receiver 'Microsoft.Office.Server.WebAnalytics.UsageLogging.SPRequestUsageReceiver'.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           884n High     Executing receiver method...
 Processing usage entries for SPRequestUsageReceiver
 Usage Logging Importer: Importing Page View Usage Entries
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           884o High     Executed receiver method.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           884m High     Called 'UsageImported' method of Usage Receiver 'Microsoft.SharePoint.Administration.SPUsageReceiverDefinition' for Usage Definition 'Microsoft.SharePoint.Administration.SPRequestUsageDefinition'.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852u High     Called ImportEntries method for usage definition 'Microsoft.SharePoint.Administration.SPRequestUsageDefinition'.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852v High     Flushed usage entries cache to storage.
 Updating SPPersistedObject SPUsageServiceInstance. Version: 370741 Ensure: True, HashCode: 32202251, Id: 4e2b32e0-ce12-4c84-a5b2-822d26c85626, Stack:    at Microsoft.SharePoint.Administration.SPPersistedObject.BaseUpdate()     at Microsoft.SharePoint.Administration.SPUsageLogImporter.StoreCurrentFileProgress(FileInfo currentFile, Int32 currentFileProgress)     at Microsoft.SharePoint.Administration.SPUsageLogImporter.FlushUsageCache(Boolean force)     at Microsoft.SharePoint.Administration.SPUsageLogImporter.ImportUsageLogFiles(List`1 usageLogFileList)     at Microsoft.SharePoint.Administration.SPUsageLogImporter.ImportUsageData()     at Microsoft.SharePoint.Administration.SPUsageImportJobDefinition.Execute(Guid targetInstanceId)     at Microsoft.SharePoint.Administration.SPTimerJobInvokeI...
 ...nternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852m High     Deleting usage log file 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1357.usage' after data import.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852m High     Deleting usage log file 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1402.usage' after data import.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852m High     Deleting usage log file 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1407.usage' after data import.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852m High     Deleting usage log file 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1412.usage' after data import.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852m High     Deleting usage log file 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1417.usage' after data import.
 OWSTIMER.EXE (0x0A0C)                    0x11FC SharePoint Foundation          Usage Infrastructure           852m High     Deleting usage log file 'C:\Program Files\Common Files\Microsoft Shared\Web Server Extensions\14\LOGS\ITD-018-20120317-1422.usage' after data import.
 Ended usage log file import.
 End usage service data import job.
 Leaving Monitored Scope (Timer Job job-usage-log-file-import). Execution Time=814.329049435067
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=2.68039997389626
 Entering monitored scope (Timer Job DocumentSetMetadataSync)
 Leaving Monitored Scope (Timer Job DocumentSetMetadataSync). Execution Time=2.02853960546683
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=1.9808782736919
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.87602334378705
 Entering monitored scope (Timer Job Indexing Schedule Manager on itd-018)
 OWSTIMER.EXE (0x0A0C)                    0x1C0C SharePoint Server Search       Administration                 dj6u High     executing job Indexing Schedule Manager on itd-018
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Entering monitored scope (Timer Job job-solution-resource-usage-update)
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=5.5144160863594
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-update). Execution Time=3.96908905996455
 Leaving Monitored Scope (Timer Job Indexing Schedule Manager on itd-018). Execution Time=126.978220237881
 Entering monitored scope (Timer Job VariationsSpawnSites)
 OWSTIMER.EXE (0x0A0C)                    0x21A4 Web Content Management         Site Management                c07h High     SpawnVariationSitesJob has started
 OWSTIMER.EXE (0x0A0C)                    0x21A4 Web Content Management         Site Management                c07i High     SpawnVariationSitesJob has finished. Time Spent: 00:00:00.0010001
 Leaving Monitored Scope (Timer Job VariationsSpawnSites). Execution Time=1.91745203986834
 Entering monitored scope (Timer Job VariationsSpawnSites)
 OWSTIMER.EXE (0x0A0C)                    0x1694 Web Content Management         Site Management                c07h High     SpawnVariationSitesJob has started
 OWSTIMER.EXE (0x0A0C)                    0x1694 Web Content Management         Site Management                c07i High     SpawnVariationSitesJob has finished. Time Spent: 00:00:00.0010001
 Entering monitored scope (Timer Job job-solution-resource-usage-update)
 Leaving Monitored Scope (Timer Job VariationsSpawnSites). Execution Time=5.65520032790996
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-update). Execution Time=8.39096077179094
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.43036129489239
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x0A7C Web Content Management         Site Management                c07h High     VariationCreateSites has started
 OWSTIMER.EXE (0x0A0C)                    0x0A7C Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00
 Leaving Monitored Scope (Timer Job VariationsCreateSite). Execution Time=1.99884292951476
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.91378578357796
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=1.86942408246437
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=2.56344639823316
 Executing the Web Anal
 Executing the Web Analyt
 Executing the Web Analytics compon
 Entering monitored scope (Timer Job SchedulingApproval)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=3.15664666601652
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.56821253141065
 Topology cache updated. (AppDomain: /LM/W3SVC/1059487122/ROOT-1-129764516568605166)
 Executing the Web Analytics comp
 Entering monitored scope (Timer Job job-solution-resource-usage-log)
 Entering monitored scope (Timer Job job-solution-resource-usage-update)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-log). Execution Time=4.49373033511782
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-update). Execution Time=5.70432816220104
 Entering monitored scope (Timer Job job-immediate-alerts)
 Leaving Monitored Scope (Timer Job job-immediate-alerts). Execution Time=10.4147342440803
 Entering monitored scope (Timer Job job-workflow-failover)
 Entering monitored scope (Timer Job DocumentSetMetadataSync)
 Leaving Monitored Scope (Timer Job job-workflow-failover). Execution Time=6.04382349469016
 Entering monitored scope (Timer Job FAST Search Server 2010 for SharePoint Master Job)
 Leaving Monitored Scope (Timer Job DocumentSetMetadataSync). Execution Time=4.34304720158324
 Leaving Monitored Scope (Timer Job FAST Search Server 2010 for SharePoint Master Job). Execution Time=2.85711352709253
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x1FE8 Web Content Management         Site Management                c07h High     VariationCreateSites has started
 OWSTIMER.EXE (0x0A0C)                    0x1FE8 Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00.0010001
 Leaving Monitored Scope (Timer Job VariationsCreateSite). Execution Time=1.92295142430391
 Entering monitored scope (Timer Job job-workflow-failover)
 Leaving Monitored Scope (Timer Job job-workflow-failover). Execution Time=2.46335760150581
 Entering monitored scope (Timer Job job-workflow-failover)
 Leaving Monitored Scope (Timer Job job-workflow-failover). Execution Time=2.29251005837413
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Entering monitored scope (Timer Job SchedulingUnpublish)
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=3.10201944728987
 Leaving Monitored Scope (Timer Job SchedulingUnpublish). Execution Time=2.64153765721824
 Entering monitored scope (Timer Job job-immediate-alerts)
 Leaving Monitored Scope (Timer Job job-immediate-alerts). Execution Time=10.0191451903484
 Entering monitored scope (Timer Job job-application-server-admin-service)
 OWSTIMER.EXE (0x0A0C)                    0x0A7C SharePoint Server Search       Administration                 dkd5 High     synchronizing search service instance
 OWSTIMER.EXE (0x0A0C)                    0x0A7C SharePoint Server Search       Administration                 eff0 High     synchronizing search data access service instance
 Search application 'Search Service Application': Provision start addresses in default content source.
 Leaving Monitored Scope (Timer Job job-application-server-admin-service). Execution Time=428.895525627498
 Entering monitored scope (Timer Job job-solution-resource-usage-log)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-log). Execution Time=1.68904427297771
 Entering monitored scope (Timer Job job-workflow-failover)
 Leaving Monitored Scope (Timer Job job-workflow-failover). Execution Time=4.37347712879338
 Entering monitored scope (Timer Job SchedulingApproval)
 Entering monitored scope (Timer Job job-immediate-alerts)
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=2.04797076380584
 Leaving Monitored Scope (Timer Job job-immediate-alerts). Execution Time=7.99720484620422
 Entering monitored scope (Timer Job job-solution-resource-usage-update)
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-update). Execution Time=4.87135473302688
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=3.73334878049317
 Entering monitored scope (Timer Job job-solution-resource-usage-log)
 Entering monitored scope (Timer Job job-immediate-alerts)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-log). Execution Time=6.72354741092647
 Entering monitored scope (Timer Job job-solution-resource-usage-update)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-update). Execution Time=5.84071289620315
 Leaving Monitored Scope (Timer Job job-immediate-alerts). Execution Time=11.9237653332004
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x1280 Web Content Management         Site Management                c07h High     VariationCreateSites has started
 Entering monitored scope (Timer Job job-application-server)
 OWSTIMER.EXE (0x0A0C)                    0x1280 Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00.0020002
 Leaving Monitored Scope (Timer Job job-application-server). Execution Time=2.45309208389274
 Entering monitored scope (Timer Job MetadataHubTimerJob)
 Metadata Hub timer job starts.
 Leaving Monitored Scope (Timer Job VariationsCreateSite). Execution Time=3.29156489750247
 WcfSendRequest: RemoteAddress: 'http://itd-018:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'Microsoft.SharePoint.Taxonomy.IMetadataWebServiceApplication' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IMetadataWebServiceApplication/GetIsServiceApplicationPartitioned' MessageId: 'urn:uuid:d2bf4c7b-3e81-46a2-a5f7-8afe21692893'
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=2.84868113762466
 WcfReceiveRequest: LocalAddress: 'http://itd-018...ae:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IMetadataWebServiceApplication/GetIsServiceApplicationPartitioned' MessageId: 'urn:uuid:d2bf4c7b-3e81-46a2-a5f7-8afe21692893'
 Entering monitored scope (ExecuteWcfServerOperation)
 Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=1.9277175574814
 WcfSendRequest: RemoteAddress: 'http://itd-018:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'Microsoft.SharePoint.Taxonomy.IMetadataWebServiceApplication' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IMetadataWebServiceApplication/GetServiceSettings' MessageId: 'urn:uuid:494fdf93-fcec-45a8-8ea5-9d98b6750225'
 WcfReceiveRequest: LocalAddress: 'http://itd-018...ae:32843/8cb180d156c84e278169cd2e9755caf5/MetadataWebService.svc' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://schemas.microsoft.com/sharepoint/taxonomy/soap/IMetadataWebServiceApplication/GetServiceSettings' MessageId: 'urn:uuid:494fdf93-fcec-45a8-8ea5-9d98b6750225'
 Entering monitored scope (ExecuteWcfServerOperation)
 Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=2.5880103153787
 OWSTIMER.EXE (0x0A0C)                    0x1370 SharePoint Foundation          Monitoring                     b4ly High     Leaving Monitored Scope (ExecuteWcfOperation:http://schemas.microsoft.com/sharepoint/taxonomy/soap/IMetadataWebServiceApplication/GetServiceSettings). Execution Time=240.292303281519
 Metadata Hub timer job ends.
 Leaving Monitored Scope (Timer Job MetadataHubTimerJob). Execution Time=257.569169424302
 Entering monitored scope (Timer Job job-solution-resource-usage-log)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-log). Execution Time=1.4965658177328
 Entering monitored scope (Timer Job Query Logging)
 Entering monitored scope (Timer Job DocumentSetMetadataSync)
 Leaving Monitored Scope (Timer Job Query Logging). Execution Time=3.47781071705374
 Leaving Monitored Scope (Timer Job DocumentSetMetadataSync). Execution Time=3.26736760598597
 Entering monitored scope (Timer Job SchedulingApproval)
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x0A7C Web Content Management         Site Management                c07h High     VariationCreateSites has started
 OWSTIMER.EXE (0x0A0C)                    0x0A7C Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00.0010001
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=3.58523202636185
 Leaving Monitored Scope (Timer Job VariationsCreateSite). Execution Time=3.64829163455637
 Entering monitored scope (Timer Job job-solution-resource-usage-log)
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-log). Execution Time=1.70260942125211
 Entering monitored scope (Timer Job VariationsSpawnSites)
 OWSTIMER.EXE (0x0A0C)                    0x1C78 Web Content Management         Site Management                c07h High     SpawnVariationSitesJob has started
 OWSTIMER.EXE (0x0A0C)                    0x1C78 Web Content Management         Site Management                c07i High     SpawnVariationSitesJob has finished. Time Spent: 00:00:00.0010001
 Entering monitored scope (Timer Job SchedulingApproval)
 Leaving Monitored Scope (Timer Job VariationsSpawnSites). Execution Time=3.31062943021244
 Entering monitored scope (Timer Job VariationsSpawnSites)
 OWSTIMER.EXE (0x0A0C)                    0x09B4 Web Content Management         Site Management                c07h High     SpawnVariationSitesJob has started
 Leaving Monitored Scope (Timer Job SchedulingApproval). Execution Time=3.86166775065644
 OWSTIMER.EXE (0x0A0C)                    0x09B4 Web Content Management         Site Management                c07i High     SpawnVariationSitesJob has finished. Time Spent: 00:00:00.0010001
 Entering monitored scope (Timer Job Health Statistics Updating)
 Leaving Monitored Scope (Timer Job VariationsSpawnSites). Execution Time=4.82259352436484
 Updating SPPersistedObject SearchServiceApplicationMonitoring Name=Monitoring_7F19A5D194F942e6A9856FCFD6EE6F63. Version: 370801 Ensure: False, HashCode: 47604217, Id: 271e0a48-8c75-4029-befd-1444fed8810f, Stack:    at Microsoft.SharePoint.Administration.SPPersistedObject.BaseUpdate()     at Microsoft.Office.Server.Search.Monitoring.TraceDiagnosticsProvider.UpdateServiceApplicationHealthStats()     at Microsoft.SharePoint.Administration.SPTimerJobInvokeInternal.Invoke(SPJobDefinition jd, Guid targetInstanceId, Boolean isTimerService, Int32& result)     at Microsoft.SharePoint.Administration.SPTimerJobInvoke.Invoke(TimerJobExecuteData& data, Int32& result) 
http://www.youtube.com/watch?v=ItrIHJWsD4M
 Entering monitored scope (Timer Job DocumentSetMetadataSync)
 Entering monitored scope (Timer Job job-storage-metrics-processing)
 Leaving Monitored Scope (Timer Job DocumentSetMetadataSync). Execution Time=3.4987083779089
 Leaving Monitored Scope (Timer Job job-storage-metrics-processing). Execution Time=6.86433165247703
 Leaving Monitored Scope (Timer Job Health Statistics Updating). Execution Time=33.4164595842905
 CGatherer::AdviseStatus Gatherer sprocs marked successfully for recompile, application Search_Service_Application  [gatherobj.cxx:2356]  d:\office\source\search
 Entering monitored scope (Timer Job job-solution-resource-usage-log)
 Entering monitored scope (Timer Job VariationsCreateSite)
 OWSTIMER.EXE (0x0A0C)                    0x2358 Web Content Management         Site Management                c07h High     VariationCreateSites has started poll
 OWSTIMER.EXE (0x0A0C)                    0x2358 Web Content Management         Site Management                c07i High     VariationCreateSites has finished. Time Spent: 00:00:00.0020002
 Leaving Monitored Scope (Timer Job job-solution-resource-usage-log). Execution Time=3.49614199850563