Monday, August 21, 2017

Common queries regarding Dynamics CRM Asynchronous Service in Dynamics CRM 2011, 2013, 2015, 2016, D365

here is a nice link and very details on Asynch Service on CRM

https://blogs.msdn.microsoft.com/emeadcrmsupport/2014/03/07/common-queries-regarding-dynamics-crm-asynchronous-service/

http://www.powerobjects.com/2016/08/08/crm-asynchronous-service-performance-settings/

https://support.microsoft.com/en-sg/help/2489162/how-to-improve-microsoft-crm-async-performance-on-multi-core-servers

Regards,
Yes.sudhanshu

Thursday, January 12, 2017

Relevance Search in Dynamics 365 Online

this is a very unique and great feature, but only available in online. doubt when it will be available for on prem. this is also available in mobile clients.

Relevance Search delivers fast and comprehensive search results in a single list, sorted by relevance. It uses a dedicated search service external to Microsoft Dynamics 365 (online) powered by Microsoft Azure Search to improve your Microsoft Dynamics 365 (online) search experience. As an administrator or customizer, you'll be able to enable and configure Relevance Search in the Dynamics 365 user interface without writing code. Many of the configuration steps will look familiar to you, as they use the same user interface as the Quick Find configuration.

Compare Dynamics 365 searches

There are three kinds of search in Dynamics 365:

The following table provides a brief comparison of the three available searches.
FunctionalityRelevance SearchFull-Text Quick FindQuick Find
AvailabilityAvailable for Microsoft Dynamics 365 (online) organizations that have installed Microsoft Dynamics CRM Online 2016 Update. Not available for Dynamics 365 (on-premises) organizations. Available for Dynamics 365 (on-premises) organizations, starting with Microsoft Dynamics CRM 2015 Update Rollup 1. Available for Microsoft Dynamics 365 (online) organizations and Dynamics 365 (on-premises) organizations.
Enabled by default? No. An administrator must manually enable it. No. An administrator must manually enable it.Yes
Single-entity search scopeNot available in an entity grid. You can filter the search results by an entity on the results page.Available in an entity grid. Available in an entity grid.
Multi-entity search scopeThere is no maximum limit on the number of entities you can search.Searches up to 10 entities, grouped by an entity. Searches up to 10 entities, grouped by an entity.
Search behaviorFinds matches to any word in the search term in any field in the entity.Finds matches to all words in the search term in one field in an entity; however, the words can be matched in any order in the field.Finds matches as in a SQL query with “Like” clauses. You have to use the wildcard characters in the search term to search within a string. All matches must be an exact match to the search term.
Search resultsReturns the search results in order of their relevance, in a single list.For single-entity, returns the search results in an entity grid. For multi-entity, returns the search results grouped by categories, such as accounts, contacts, or leads.For single-entity, returns the search results in an entity grid. For multi-entity, returns the search results grouped by categories, such as accounts, contacts, or leads.

How Relevance Search works

Relevance Search uses the same default scoring concepts as Azure Search. Scoring refers to the computation of a search score for every item returned in search results. The score is an indicator of an item's relevance in the context of the current search operation. The higher the score, the more relevant the item. In search results, items are ranked in order from high to low, based on the search scores calculated for each item. By default, a search score is computed based on statistical properties of the data and the query. Relevance Search finds documents that include the search terms in the query string, favoring the documents that contain many instances of the words in the search term and their close proximity to each other in the document. The search score goes up even higher if the term is rare across the index, but common within the document. The results are then ranked by search score before they’re returned. Search score values can be repeated throughout a result set. For example, you might have 10 items with a score of 1.2, 20 items with a score of 1.0, and 20 items with a score of 0.5. When multiple hits have the same search score, the ordering of same-score items isn’t defined, and isn’t stable. Run the query again and you might see items shift position. Given two items with an identical score, there is no guarantee which one appears first.

Searchable fields are analyzed in the Azure Search index to provide a more natural, end-user friendly search experience by breaking words into their root forms, text normalization, and filtering out noise words. All searchable fields in Relevance Search are analyzed with the Microsoft Natural language analyzer, which uses Lemmetization to break words down into their root linguistic forms. For example, “ran” will match to “run” and “running” since “run” is considered the base form of the word. Word stemmers, such as SQL full-text indexes, don’t have any linguistic context and only consider matches where the root is the same as the inflectional form. With stemming, “run” would match to “running” and “runner”, but not “ran” since it doesn’t consider “ran” to be a word linguistically related to “run”. All searchable fields in Relevance Search use an analyzer that most closely matches the organization’s base language. For Kazakh, which is the only language supported by Dynamics 365 but not by Azure Search, all fields are analyzed using the default analyzer.


Enable Relevance Search

By default, Relevance Search is disabled. To enable Relevance Search, do the following:

  1. Go to Settings > Administration.
  2. Click System Settings > General tab.
  3. In the Set up Search sub-area, select the Enable Relevance Search check box, as shown here. Do not click Select here.


4.After you enable Relevance Search, the Enable Search consent dialog box opens. Click OK to give your consent. 

Select entities for Relevance Search

There is no limit on how many entities you can include in the Relevance Search results. However, there is a limit on the total number of fields you index. Currently, the maximum is 1000 searchable fields for an organization. When you select an entity to include in the search results, you’ll notice a number in parentheses next to the entity name. The number indicates how many fields of the entity will be synced to the external search index. Some fields, such as Primary Name and ID, are shared by multiple entities and don't count toward the total. The progress bar Total fields indexed shows the percentage of indexed fields to the maximum allowed number of searchable fields.
When you have reached the indexed field limit, you’ll see a warning message. If you want to add more fields to the index, you’ll have to free up space, either by removing some of the fields that are already in the index or removing entire entities from Relevance Search.
To select entities for the Relevance Search results, do the following:


  1. Go to Settings > Customizations.
  2. Click Customize the System.
  3. Under Components, expand Entities, and then click Configure Relevance Search.
  1. Click Publish All Customizations for your changes to take effect.

The fields you add in Quick Find view become part of the external search index. There is no limit on how many searchable fields you can add for each entity. However, there is a limit on the total number of indexed fields, as was explained in the previous section. Find Columns on a Quick Find View define the searchable fields in the external search index. The View Columns on a Quick Find View define the fields that are displayed in the user interface by default, when the matched results are returned. The fields that are highlighted replace the fields that don’t have the highlighting. The first four matched fields are displayed in the results.
You can use the Quick Find view to define which fields appear as facets when users search by using Relevance Search. All View Columns with data types other than Single Line of Text and Multiple Lines of Text are marked as facetable and filterable in the index. By default, the first four facetable fields in the Quick Find view for the selected entity are displayed as facets when users search by using Relevance Search. At any time, you can only have four fields selected as facets.



  1.  Click Add Find Columns. In the dialog box, select the fields you want to add to the search index. When done, click OK. In the following illustration, you see the Account entity fields added to the external search index. 

If you want to include an entity in Relevance Search, the Can enable sync to external search index managed property for this entity must be set to True. By default, the property is set to True for some of the out-of-the-box system entities and all custom entities. Some of the system entities can’t be enabled for Relevance Search.
To set the managed property, do the following:


  1. Go to Settings > Customizations.
  2. Click Customize the System.
  3. Under Components, expand Entities, and then click the entity you want.
  4. On the menu bar, click Managed Properties. For Can enable sync to external search index, click True or False to set the property to the desired state. Click Set to exit, as shown here

        Click Publish for your changes to take effect.
    If you want to change the Can enable sync to external search index property to False, you must first deselect the entity from Relevance search. If the entity is included in Relevance Search, you’ll see the following message: “This entity is currently syncing to an external search index. You must remove the entity from the external search index before you can set the Can Enable Sync to External Search Index property to False.” If Can Enable Sync to External Search Index is set to False, you’ll see the following message when you try to include an entity in Relevance Search: “Entity can’t be enabled for Relevance Search because of the configuration of its managed properties.” For custom entities with particularly sensitive data, you may consider setting the Can enable sync to external search index property to False. Keep in mind, after you install the managed solution on the target system, you won’t be able to change the value of the property because it’s a managed property.

    Privacy notice

    By enabling Relevance Search, data in participating entities and attributes in your Dynamics 365 (online) instance will begin syncing to and be stored in an Azure Search index.
    Relevance Search is not enabled by default. The system administrator must enable the functionality within a Dynamics 365 (online) instance. After Relevance Search is enabled, system administrators and customizers have full control over the data that will be synchronized to the Azure Search index.
    System customizers can use the Configure Relevance Search dialog box in Customization Tools to enable specific entities for search and then configure Quick Find views on enabled entities to select the searchable attributes. Data changes are synchronized continuously between Dynamics 365 (online) and Azure Search through a secure connection. Configuration data is encrypted and the required secrets are stored in Azure Key Vault.
    Azure components and services that are involved with Relevance Search functionality are detailed in the following sections. 

Tuesday, December 27, 2016

Duplicate detection rules in Dynamics CRM 2015, 2016, Dynamics 365

to share, when I was working with dynamics crm duplicate detection rules, below my observations w.r.t auto save.


Auto save does not work on create. its simple why, cause this does take care of the mandatory fields enter or not etc.


when u have already a record present and now you are creating a new with same values as per your duplicate rule, when you save, the rule will run and  you will be prompted with the duplicate records and an option if you want to save this also or not.




when you have opened and updating a record, if you are editing and updating to same set of values as per duplicate rule, if you immediately same by your own, then will be prompted with duplicate records and an option as above scenario.


else if the auto save triggered before you hit save button, then there will be a balloon message as below screen and one you click "Resolve Duplicate", it will prompt the above scenario screen with all duplicate records and options, else if you click "Save Anyway", it will just create another duplicate record.

Saturday, November 19, 2016

workflow must be in published state error message while saving Case record in Dynamics CRM 2016 online

while working on dynamics crm 2016 online I got below error while saving case record.
"workflow must be in published state". once download the message I got below


Unhandled Exception: System.ServiceModel.FaultException`1[[Microsoft.Xrm.Sdk.OrganizationServiceFault, Microsoft.Xrm.Sdk, Version=8.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35]]: Workflow must be in Published state.Detail:
<OrganizationServiceFault xmlns:i="http://www.w3.org/2001/XMLSchema-instance" xmlns="http://schemas.microsoft.com/xrm/2011/Contracts">
  <ErrorCode>-2147200953</ErrorCode>
  <ErrorDetails xmlns:d2p1="http://schemas.datacontract.org/2004/07/System.Collections.Generic">
    <KeyValuePairOfstringanyType>
      <d2p1:key>0</d2p1:key>
      <d2p1:value xmlns:d4p1="http://www.w3.org/2001/XMLSchema" i:type="d4p1:string">Workflow must be in Published state.</d2p1:value>
    </KeyValuePairOfstringanyType>
    <KeyValuePairOfstringanyType>
      <d2p1:key>1</d2p1:key>
      <d2p1:value xmlns:d4p1="http://www.w3.org/2001/XMLSchema" i:type="d4p1:string">workflowId</d2p1:value>
    </KeyValuePairOfstringanyType>
  </ErrorDetails>
  <Message>Workflow must be in Published state.</Message>
  <Timestamp>2016-11-19T14:29:41.1347733Z</Timestamp>
  <ExceptionSource i:nil="true" />
  <InnerFault i:nil="true" />
  <OriginalException i:nil="true" />
  <TraceText>
[Microsoft.Crm.Service.ObjectModel: Microsoft.Crm.Service.ObjectModel.CasePostCreatePlugin]
[ffde44b1-a685-4948-85b8-e4091bc2a98b: CasePostCreatePlugin]
 
               
                [Microsoft.Crm.ObjectModel: Microsoft.Crm.Extensibility.InternalOperationPlugin]
                [46f6cf4c-14ae-4f1e-98a1-eae99a37e95c: ExecuteWorkflowWithInputArguments]
               
               
</TraceText>
</OrganizationServiceFault>
strange, I activated all workflows, business process, still same issue.
then I deleted all (taken back up) 1st, still same issue.
then I just though to see anything related to case, I landed to SLA.
I just deactivated, then I was able to save Case record.
even then I activated SLA, also I was able to save.


SO JUST deactivate and activate again is the solution. but do not know why?


Regards,
yes.sudhashu

Thursday, September 29, 2016

Dynamics CRM App for Outlook Client (light weight App)

There is a cool App (https://technet.microsoft.com/en-us/library/dn946901.aspx ) available for Dynamics CRM online only (as of now)
here below are step by step and some more details....


1st RULE: this is only available for MS CRM 2016 Online.
so you can use office 365 out look or offline outlook client also, but ms crm will be on line version.


Basic settings
once you login to your online dynamics crm instance, you will find something below, if you will click on the gear icon on top right corner of your screen
here you see dynamics crm app for phone and tablets for all 3 major mobile player, Windows, Apple and Android (from google)


next you will see the "Dynamics CRM App for outlook".
as in above screen , if you see the red cross and message "your account's email settings aren't configured to use this app", then login to crm and setup the email account in users profile that you are accessing now and then you will see as below.

this means, for this user, the email account mentioned in the user profile will be able to get the app for outlook. the message says "we are adding the app in background". finally you will see as below with message "Already added to your outlook". now you are ready to use the app for this email is , either on office 365 or in your outlook if you have configured this account in outlook.


for Office 365
now login to your office 365 email account and once you select any email, on right side panel you will see "Dynamics CRM icon" as below. have patience if it does not load immediately , may take some time.


Once you click that , it will launch the App. it will download the metadata as below
then it will load below screen as per the logic, if the contact present in crm or not, it will ask you to track the email in crm or not etc as below.
if you click Track, then you have choice to set regarding (this has option to search and find) or also without set regarding you can track in crm as below
if you s
earch you will get the rsults as below for each entities....



then there is option you can Untrack and also change regarding value for the email tracked in CRM as below....
While searching for a record to set regarding, if it is not present you can just go ahead and create a new record by clicking the + icon as below highlighted....
after clicking the icon (say clicked Case) it will open up the new record form (here case), this might open the quick create form as below...

this is all about the app in office 365.

for Outlook client
for this you need to install the outlook client that is available in crm or can download from internet.
select online while configuring the org.
then in the outlook, you will see login screen as below.
once you login it will connect to the online crm org as below
once you select any email from that email account in outlook you will get below screen to Track, change, untrack depending on new email or tracked email. here its for one tracked email, so change and untrack.
if you select track you will get the same kind of screen as we got for office 356 login, same search, create new record etc.

Security role for crm outlook app
there is a security role needs to be enabled for the user to get the app, this also needs to be granted in the security role , so that the user will not see the red cross in image 1.

you can the eligible users from CRM by going to Settings -> CRM App for Outlook. this will list out the user which are eligible, means granted to access outlook app access.

hope this is a great step from MS. this will help from many angles....
at least for online users they do not have to install outlook client , unless they need to access more crm from outlook.

hope this also helps people to understand some...

Regards,
Sudhanshu



Thursday, September 8, 2016

MS CRM 2016 SharePoint integration error "The server encountered an error processing the request. see server logs for more details."

while setting up ms crm 2016 and sharepoint 2016 server side for document management, I got below error while accessing metadataendpoint URL http://crmbox:81/XrmServices/2015/metadataendpoint.svc/json/?orgName=Agency


this message was not enough to understand.

hence I have used crm diagnostic tool to get more details of error.
after running the tool I got below details in log .. just see the highlighted one
SELECT  Id, [CertificateData], [Name], [ParentId], [StoreFindType], [StoreLocation], [StoreName], [Type]  FROM [Certificates]   WHERE ((([Type] = 'S2STokenIssuer'))  OR (([Type] = 'AlternativeS2STokenIssuer')) )

when I ran this query in MSCRM_CONFIG DB, I got no result. but in another env, where it was working fine, I got one result.
then another message in the log file said

TraceHandledException.aspxHandling an exception. Exception details: Microsoft.Crm.CrmException: No S2STokenIssuer certificate present in config database.

this says very clearly that there is no S2TokenIssuer. so found that, some how below command was not executed . you can follow https://technet.microsoft.com/en-us/library/dn949332.aspx for details of document management.

.\CertificateReconfiguration.ps1 -certificateFile c:\Personalcertfile.pfx -password personal_certfile_password -updateCrm -certificateType S2STokenIssuer -serviceAccount contoso\CRMAsyncService -storeFindType FindBySubjectDistinguishedName


details log


# CRM Tracing Version 2.0
# LocalTime: 2016-09-08 14:48:03.321
# Categories: *:Verbose
# CallStackOn: No
# ComputerName: CRMBOX
# CRMVersion: 8.0.0000.1088
# DeploymentType: OnPremise
# ScaleGroup:
# ServerRole: AppServer, AsyncService, DiscoveryService, ApiServer, HelpServer, DeploymentService, SandboxServer, DeploymentManagementTools, VssWriter, EmailConnector
 
[2016-09-08 14:48:03.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:03.416] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id, [ActiveEndpoint], [ActiveMexEndpoint], [Enabled], [IdentityClaim], [MetadataUri], [Name], [PassiveEndpoint], [RelyingPartyActiveIdentifier], [RelyingPartyPassiveIdentifier]  FROM [FederationProvider]   WHERE ((([Id] = '26332692-cd1e-4dd6-bd5b-07326c43302e')) )
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id, [ActiveEndpoint], [ActiveMexEndpoint], [Enabled], [IdentityClaim], [MetadataUri], [Name], [PassiveEndpoint], [RelyingPartyActiveIdentifier], [RelyingPartyPassiveIdentifier]  FROM [FederationProvider]   WHERE ((([Id] = '26332692-cd1e-4dd6-bd5b-07326c43302e')) ) ; CommandTimeout: 30.
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [FederationProviderProperties]  WHERE Id IN (SELECT [Id] FROM [FederationProvider]  WHERE ((([Id] = '26332692-cd1e-4dd6-bd5b-07326c43302e')) ))
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [FederationProviderProperties]  WHERE Id IN (SELECT [Id] FROM [FederationProvider]  WHERE ((([Id] = '26332692-cd1e-4dd6-bd5b-07326c43302e')) )); CommandTimeout: 30.
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id  FROM [DataEncryptionKey]   WHERE ((([IsConfigurationRow] = 1)) )
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id  FROM [DataEncryptionKey]   WHERE ((([IsConfigurationRow] = 1)) ) ; CommandTimeout: 30.
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id, [CrmKeyName]  FROM [DataEncryptionKey]   WHERE ((([IsConfigurationRow] = 0)) )
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id, [CrmKeyName]  FROM [DataEncryptionKey]   WHERE ((([IsConfigurationRow] = 0)) ) ; CommandTimeout: 30.
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id, [UniqueName], [State]  FROM [Organization]  
[2016-09-08 14:48:03.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id, [UniqueName], [State]  FROM [Organization]   ; CommandTimeout: 30.
[2016-09-08 14:48:04.228] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   18(MSCRM:-NotificationManager.NotificationWatcherThreadProc) |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Warning |ReqId: 00000000-0000-0000-0000-000000000000 | ExecutionContext.RunInternal  ilOffset = 0x79
>NotificationWatcherThread Started.
[2016-09-08 14:48:04.244] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   19(MSCRM:-MetadataCache.RemoveUnusedCachesThreadProc) |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | ExecutionContext.RunInternal  ilOffset = 0x79
>RemoveUnusedCachesThreadProc Started.
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id  FROM [Server]   WHERE ((([Name] = 'CRMBOX')) )
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id  FROM [Server]   WHERE ((([Name] = 'CRMBOX')) ) ; CommandTimeout: 30.
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id, [DatacenterId], [FullName], [Name], [PodId], [Roles], [ScaleGroupId], [State], [StorageGroupId], [UniqueifierId], [Version]  FROM [Server]   WHERE ((([Id] = '746c799a-2544-e611-80be-080027c30349')) )
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id, [DatacenterId], [FullName], [Name], [PodId], [Roles], [ScaleGroupId], [State], [StorageGroupId], [UniqueifierId], [Version]  FROM [Server]   WHERE ((([Id] = '746c799a-2544-e611-80be-080027c30349')) ) ; CommandTimeout: 30.
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [ServerProperties]  WHERE Id IN (SELECT [Id] FROM [Server]  WHERE ((([Id] = '746c799a-2544-e611-80be-080027c30349')) ))
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [ServerProperties]  WHERE Id IN (SELECT [Id] FROM [Server]  WHERE ((([Id] = '746c799a-2544-e611-80be-080027c30349')) )); CommandTimeout: 30.
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Etm |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | RequestGovernor.Initialize  ilOffset = 0xB
>RequestGovernor disabled
[2016-09-08 14:48:04.259] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | VirtualPathProviderInitializer.Microsoft.Crm.IApplicationInitializer.Initialize  ilOffset = 0x13
>Initialize MapOrgVirtualPathProvider.
[2016-09-08 14:48:04.274] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | RunInitializerTracker.TryRun  ilOffset = 0x29
>Initialize: enter
[2016-09-08 14:48:04.274] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | RunInitializerTracker.TryRun  ilOffset = 0x29
>Initialize: first time
[2016-09-08 14:48:04.274] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x49
>SandboxTraceProvider.Initialize: enter
[2016-09-08 14:48:04.274] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x49
>SandboxTraceProvider.Initialize: exit
[2016-09-08 14:48:04.274] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxPerformanceCounter.InitializeCounters  ilOffset = 0x16
>_eventSource: MSCRMSandboxClient
[2016-09-08 14:48:04.274] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x53
>InitializeInternal: enter
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostMinWorkerProcesses
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostMaxWorkerProcesses
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostMaxAssemblyCacheSizeInMByte
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostMaxWorkerProcessHandleCount
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostAssemblyCacheExpireTimeInMin
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostAssemblyCacheMonitorIntervalInMin
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostJobMemoryLimitHighPercent
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostJobMemoryLimitLowPercent
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostWorkerProcessMemoryLimitPercent
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostJobCpuUsageLimitPercent
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostReservedCpuCount
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostCpuPerJobCount
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostPingOperationTimeoutInSec
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x18
>deploymentSettingName: SandboxHostMaxWorkerCpuUsageLimitPercent
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x1E
>deploymentSettingName: SandboxWorkerMaxWorkerIdleTimeInMin
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x1E
>deploymentSettingName: SandboxWorkerMaxWorkerLifetimeInMin
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x1E
>deploymentSettingName: SandboxWorkerShutdownTimeInMinutes
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x1E
>NestingDepth: 24
[2016-09-08 14:48:04.290] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.GetDeploymentProperties  ilOffset = 0x1E
>IncludeCallStack: True
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmServerService.RetrieveServersInPod  ilOffset = 0x29
>Retrieve multiple Servers
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id, [DatacenterId], [FullName], [Name], [PodId], [Roles], [ScaleGroupId], [State], [StorageGroupId], [UniqueifierId], [Version]  FROM [Server]   WHERE ((([State] = Enabled)) )
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id, [DatacenterId], [FullName], [Name], [PodId], [Roles], [ScaleGroupId], [State], [StorageGroupId], [UniqueifierId], [Version]  FROM [Server]   WHERE ((([State] = Enabled)) ) ; CommandTimeout: 30.
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [ServerProperties]  WHERE Id IN (SELECT [Id] FROM [Server]  WHERE ((([State] = Enabled)) ))
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [ServerProperties]  WHERE Id IN (SELECT [Id] FROM [Server]  WHERE ((([State] = Enabled)) )); CommandTimeout: 30.
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x53
>found Sandbox server: CRMBOX
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x53
>sandboxServers.Count: 1
[2016-09-08 14:48:04.306] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x53
>server.Name: CRMBOX
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.InitializeInternal  ilOffset = 0x154
>UpdateHostNames: newHostList.Count: 1
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.InitializeInternal  ilOffset = 0x154
>Adding host name: CRMBOX
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.InitializeInternal  ilOffset = 0x154
>Updating host names
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.InitializeInternal  ilOffset = 0x154
>UpdateHostNames: exit
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | ExecutionContext.RunInternal  ilOffset = 0x79
>AppDomain: /LM/W3SVC/2/ROOT-1-131177908824467939
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x53
>InitializeInternal: try to start SandboxSdkListener; _started: True, SandboxServers.Count: 1, SandboxSdkListener.ListenerStarted: False
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   15 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | ExecutionContext.RunInternal  ilOffset = 0x79
>Exiting WritePluginTraceLog
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | ExecutionContext.RunInternal  ilOffset = 0x79
>SdkListenerStarterThread: enter
[2016-09-08 14:48:04.321] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.SdkListenerStarterThread  ilOffset = 0x1A
>StartListening: _startListeningCount: 0
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.Initialize  ilOffset = 0x53
>InitializeInternal: exit
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | RunInitializerTracker.TryRun  ilOffset = 0x29
>Initialize: exit
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>ENTER: PingHosts
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>checking host names list for new machines: 1
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>in: ready clients: 0
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>in: pending clients: 0
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>checking: CRMBOX
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>new machine name: CRMBOX
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x1F5
>_singleBox: True
[2016-09-08 14:48:04.337] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>single box
[2016-09-08 14:48:04.369] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.StartListening  ilOffset = 0x10C
>Starting: SDK Listener
[2016-09-08 14:48:04.384] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.StartListening  ilOffset = 0x10C
>NetTcpBinding
[2016-09-08 14:48:04.400] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.StartListening  ilOffset = 0x10C
>Uri: net.tcp://localhost/CrmSandboxSdkListener-w3wp
[2016-09-08 14:48:04.446] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly Microsoft.Crm.Authentication.XmlSerializers, Version=8.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:04.462] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.StartListening  ilOffset = 0x10C
>throttle.MaxConcurrentCalls:100
[2016-09-08 14:48:04.462] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.StartListening  ilOffset = 0x10C
>throttle.MaxConcurrentInstances:300
[2016-09-08 14:48:04.462] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.StartListening  ilOffset = 0x10C
>throttle.MaxConcurrentSessions:200
[2016-09-08 14:48:04.509] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x218
>net.pipe://localhost/CrmSandboxHost
[2016-09-08 14:48:04.509] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x218
>no clientSpn
[2016-09-08 14:48:04.509] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x218
>created WCF channel OK
[2016-09-08 14:48:04.525] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x218
>Channel Settings: CloseTimeout: 00:01:00, OpenTimeout: 00:01:00, ReceiveTimeout: 00:10:00, SendTimeout: 00:01:00, MaxBufferPoolSize: 524288, MaxBufferSize: 128974848, MaxConnections: 10, MaxReceivedMessageSize: 128974848, TransferMode: Buffered,
[2016-09-08 14:48:04.525] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x279
>PingSingleClient: enter: CRMBOX
[2016-09-08 14:48:04.525] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x279
>pinging: CRMBOX
[2016-09-08 14:48:04.541] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCallInfo..cctor  ilOffset = 0x49
>SandboxCallInfo static ctor
[2016-09-08 14:48:04.541] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCallInfo..cctor  ilOffset = 0x83
>_scaleGroupId: 00000000-0000-0000-0000-000000000000
[2016-09-08 14:48:04.541] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCallInfo..cctor  ilOffset = 0x139
>_serviceClassForServerPrincipalName: HTTP
[2016-09-08 14:48:04.588] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingSingleClient  ilOffset = 0xF9
>SandboxHostSids.AddSid: crmbox; hostSidSddlForm: AGENCY\CRMSANDBOX;S-1-5-21-2247622700-1530773878-3142798104-1111
[2016-09-08 14:48:04.588] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x279
>pingClient.HostStatus: Ready
[2016-09-08 14:48:04.588] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>adding to ready list: CRMBOX
[2016-09-08 14:48:04.588] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>CRMBOX: removedFromPending: False
[2016-09-08 14:48:04.588] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>checking bad list: 0
[2016-09-08 14:48:04.588] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>out: ready clients: 1
[2016-09-08 14:48:04.588] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>out: pending clients: 0
[2016-09-08 14:48:04.604] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHostsInternal  ilOffset = 0x47E
>>>>>>>>>>> 
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x6A1
>_totalNumberSandboxHosts: 1
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x6BF
>percentHealthySandboxHosts: 100
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x6DD
>executeResponseTimeInMsec: 0
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x6FB
>percentExecuteFailures: 0
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x719
>executesPerSecond: 0
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x737
>sdkResponseTimeInMSec: 0
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x755
>percentSdkRequestFailures: 0
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x773
>sdkRequestsPerSecond: 0
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.Monitoring |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxCounter.PublishCounters  ilOffset = 0x785
><<<<<<<<<< 
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxHostManager.PingHosts  ilOffset = 0x35
>EXIT: PingHosts
[2016-09-08 14:48:04.619] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   14 |Category: Sandbox.LoadBalancer |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 00000000-0000-0000-0000-000000000000 | ExecutionContext.RunInternal  ilOffset = 0x79
>_loopCount: 1
[2016-09-08 14:48:04.634] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox.StartStop |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | SandboxSdkListener.StartListening  ilOffset = 0x10C
>Started: SDK Listener
[2016-09-08 14:48:04.634] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   20 |Category: Sandbox |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | ExecutionContext.RunInternal  ilOffset = 0x79
>SdkListenerStarterThread: exit/success
[2016-09-08 14:48:05.416] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly CrmAsyncService, Version=4.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:05.416] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly CrmAsyncService, Version=4.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:05.416] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly CrmAsyncService, Version=4.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:05.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly CrmAsyncService, Version=4.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:05.431] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly CrmAsyncService, Version=4.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:06.041] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 00000000-0000-0000-0000-000000000000 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly Microsoft.Practices.TransientFaultHandling.Core, Version=5.1.1209.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:06.822] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Authentication |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | SyncEventExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute  ilOffset = 0x5D
>AUTH: Request [GET http://crmbox:5555/XrmServices/2015/metadataendpoint.svc/json?orgName=Agency] from [::1] entered Authentication Pipeline.
[2016-09-08 14:48:06.837] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:06.837] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id  FROM [AuthenticationSettings]   WHERE ((([ConfigurationName] = 'OnPremise')) )
[2016-09-08 14:48:06.837] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id  FROM [AuthenticationSettings]   WHERE ((([ConfigurationName] = 'OnPremise')) ) ; CommandTimeout: 30.
[2016-09-08 14:48:06.837] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [AuthenticationSettingsProperties]  WHERE Id IN (SELECT [Id] FROM [AuthenticationSettings]  WHERE ((([ConfigurationName] = 'OnPremise')) )) AND ColumnName IN ('CrmAuthentication')
[2016-09-08 14:48:06.837] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [AuthenticationSettingsProperties]  WHERE Id IN (SELECT [Id] FROM [AuthenticationSettings]  WHERE ((([ConfigurationName] = 'OnPremise')) )) AND ColumnName IN ('CrmAuthentication'); CommandTimeout: 30.
[2016-09-08 14:48:06.837] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Application |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | AppDomain.OnAssemblyResolveEvent  ilOffset = 0x1B
>Attempted to find assembly Microsoft.Crm.Authentication.XmlSerializers, Version=8.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35 skipped path not being under ISV folder.
[2016-09-08 14:48:06.868] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | AuthenticationPipeline.Authenticate  ilOffset = 0x11
>AUTH: AuthenticationProvider [] will be attempted.
[2016-09-08 14:48:06.868] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform.Authentication |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | AuthenticationPipeline.Authenticate  ilOffset = 0x11
>AUTH: AuthenticationProvider [Microsoft.Crm.Authentication.PassThroughAuthenticationProvider] handled request [http://crmbox:5555/XrmServices/2015/metadataendpoint.svc/json?orgName=Agency] from [::1].
[2016-09-08 14:48:06.884] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   13 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | RouteCollection.IsRouteToExistingFile  ilOffset = 0x0
>FileExists ~/XrmServices/2015/metadataendpoint.svc returning True.
[2016-09-08 14:48:06.978] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:    7 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | HostingEnvironmentWrapper.ServiceFileExists  ilOffset = 0x0
>FileExists ~/XrmServices/2015/metadataendpoint.svc returning True.
[2016-09-08 14:48:06.978] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:    7 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | BuildManager.EnsureFirstTimeDirectoryInit  ilOffset = 0x20
>DirectoryExists /XrmServices/2015/App_LocalResources/ returning False.
[2016-09-08 14:48:06.978] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:    7 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: f9dddc68-26b3-4234-9290-62876bec78d5 | BuildResult.ComputeSourceDependenciesHashCode  ilOffset = 0x8
>GetFileHash(/XrmServices/2015/metadataendpoint.svc, System.Collections.ArrayList) called.
[2016-09-08 14:48:07.103] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   15 |Category: Platform.Authentication |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | SyncEventExecutionStep.System.Web.HttpApplication.IExecutionStep.Execute  ilOffset = 0x5D
>AUTH: Request [GET http://crmbox:5555/XrmServices/2015/metadataendpoint.svc/json/?orgName=Agency] from [::1] entered Authentication Pipeline.
[2016-09-08 14:48:07.103] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   15 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | AuthenticationPipeline.Authenticate  ilOffset = 0x11
>AUTH: AuthenticationProvider [Microsoft.Crm.Authentication.PassThroughAuthenticationProvider] will be attempted.
[2016-09-08 14:48:07.103] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   15 |Category: Platform.Authentication |User: 00000000-0000-0000-0000-000000000000 |Level: Info |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | AuthenticationPipeline.Authenticate  ilOffset = 0x11
>AUTH: AuthenticationProvider [Microsoft.Crm.Authentication.PassThroughAuthenticationProvider] handled request [http://crmbox:5555/XrmServices/2015/metadataendpoint.svc/json/?orgName=Agency] from [::1].
[2016-09-08 14:48:07.103] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   15 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | RouteCollection.IsRouteToExistingFile  ilOffset = 0x0
>FileExists ~/XrmServices/2015/metadataendpoint.svc returning True.
[2016-09-08 14:48:07.103] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:07.103] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id  FROM [Organization]   WHERE ((([UniqueName] = 'Agency')) )
[2016-09-08 14:48:07.103] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id  FROM [Organization]   WHERE ((([UniqueName] = 'Agency')) ) ; CommandTimeout: 30.
[2016-09-08 14:48:07.118] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:07.118] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id, [AreReportsPublished], [AvailabilityGroup], [ConnectionString], [DatabaseName], [DatacenterId], [DelegatedAdminCrmUserId], [FriendlyName], [HelpContentServerUrl], [MirroredSqlServerName], [PartitionNumber], [ProvisioningActionInProgress], [ScaleGroupId], [SqlServerName], [SrsUrl], [State], [StorageGroupId], [StorageLicensesPurchasedModifiedOn], [SupportUserCrmUserId], [Type], [UniqueName], [UniqueifierId], [UrlName], [UserLicensesPurchasedModifiedOn]  FROM [Organization]   WHERE ((([Id] = '62d86e90-01d2-462a-a4fc-4cd113c943c6')) )
[2016-09-08 14:48:07.118] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id, [AreReportsPublished], [AvailabilityGroup], [ConnectionString], [DatabaseName], [DatacenterId], [DelegatedAdminCrmUserId], [FriendlyName], [HelpContentServerUrl], [MirroredSqlServerName], [PartitionNumber], [ProvisioningActionInProgress], [ScaleGroupId], [SqlServerName], [SrsUrl], [State], [StorageGroupId], [StorageLicensesPurchasedModifiedOn], [SupportUserCrmUserId], [Type], [UniqueName], [UniqueifierId], [UrlName], [UserLicensesPurchasedModifiedOn]  FROM [Organization]   WHERE ((([Id] = '62d86e90-01d2-462a-a4fc-4cd113c943c6')) ) ; CommandTimeout: 30.
[2016-09-08 14:48:07.118] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [OrganizationProperties]  WHERE Id IN (SELECT [Id] FROM [Organization]  WHERE ((([Id] = '62d86e90-01d2-462a-a4fc-4cd113c943c6')) ))
[2016-09-08 14:48:07.118] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT [Id], ColumnName, BigIntColumn, IntColumn, SmallIntColumn, TinyIntColumn, BitColumn, FloatColumn, DateTimeColumn, SmallDateTimeColumn, NVarCharColumn, UniqueIdentifierColumn, VarBinaryColumn FROM [OrganizationProperties]  WHERE Id IN (SELECT [Id] FROM [Organization]  WHERE ((([Id] = '62d86e90-01d2-462a-a4fc-4cd113c943c6')) )); CommandTimeout: 30.
[2016-09-08 14:48:07.134] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | MetadataEndpointServiceUtility.GetSigningCertificates  ilOffset = 0x5D
>Retrieve multiple Certificates
[2016-09-08 14:48:07.134] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Shared |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.Open  ilOffset = 0x2E
>ConnectionString: Data Source=crmbox.agency.local;Initial Catalog=MSCRM_CONFIG;Integrated Security=True;Min Pool Size=2;Connect Timeout=150;Workstation ID=CRMBOX.w3wp.
[2016-09-08 14:48:07.134] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.InternalExecuteReader  ilOffset = 0x1C
>SELECT  Id, [CertificateData], [Name], [ParentId], [StoreFindType], [StoreLocation], [StoreName], [Type]  FROM [Certificates]   WHERE ((([Type] = 'S2STokenIssuer'))  OR (([Type] = 'AlternativeS2STokenIssuer')) )
[2016-09-08 14:48:07.134] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sql |User: 00000000-0000-0000-0000-000000000000 |Level: Verbose |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmDbConnection.ExecuteReader  ilOffset = 0x9
>Query execution time: 0.0 seconds; database: MSCRM_CONFIG; Server:crmbox.agency.local; command: SELECT  Id, [CertificateData], [Name], [ParentId], [StoreFindType], [StoreLocation], [StoreName], [Type]  FROM [Certificates]   WHERE ((([Type] = 'S2STokenIssuer'))  OR (([Type] = 'AlternativeS2STokenIssuer')) ) ; CommandTimeout: 30.
[2016-09-08 14:48:07.134] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Exception |User: 00000000-0000-0000-0000-000000000000 |Level: Error |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | CrmException.Assert  ilOffset = 0x10
                at CrmException.Assert(Boolean condition, String message)  ilOffset = 0x10
                at MetadataEndpointServiceUtility.GetSigningCertificates()  ilOffset = 0x100
                at MetadataEndpointService.GenerateMetadata(String orgName)  ilOffset = 0x6A
                at   ilOffset = 0xFFFFFFFF
                at SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs)  ilOffset = 0x222
                at DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc)  ilOffset = 0xC4
                at ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc)  ilOffset = 0x48
                at ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc)  ilOffset = 0x291
                at MessageRpc.Process(Boolean isOperationContextSet)  ilOffset = 0x65
                at ChannelHandler.DispatchAndReleasePump(RequestContext request, Boolean cleanThread, OperationContext currentOperationContext)  ilOffset = 0x239
                at ChannelHandler.HandleRequest(RequestContext request, OperationContext currentOperationContext)  ilOffset = 0xEF
                at ChannelHandler.AsyncMessagePump(IAsyncResult result)  ilOffset = 0x39
                at ChannelHandler.OnAsyncReceiveComplete(IAsyncResult result)  ilOffset = 0x19
                at AsyncThunk.UnhandledExceptionFrame(IAsyncResult result)  ilOffset = 0x0
                at AsyncResult.Complete(Boolean completedSynchronously)  ilOffset = 0xC2
                at AsyncQueueReader.Set(Item item)  ilOffset = 0x2F
                at InputQueue`1.EnqueueAndDispatch(Item item, Boolean canDispatchOnThisThread)  ilOffset = 0xDE
                at InputQueue`1.EnqueueAndDispatch(T item, Action dequeuedCallback, Boolean canDispatchOnThisThread)  ilOffset = 0xE
                at SingletonChannelAcceptor`3.Enqueue(QueueItemType item, Action dequeuedCallback, Boolean canDispatchOnThisThread)  ilOffset = 0x33
                at EnqueueMessageAsyncResult.CompleteParseAndEnqueue(IAsyncResult result)  ilOffset = 0x61
                at EnqueueMessageAsyncResult.HandleParseIncomingMessage(IAsyncResult result)  ilOffset = 0x11
                at AsyncResult.SyncContinue(IAsyncResult result)  ilOffset = 0xB
                at EmptyHttpPipeline.BeginProcessInboundRequest(ReplyChannelAcceptor replyChannelAcceptor, Action dequeuedCallback, AsyncCallback callback, Object state)  ilOffset = 0x11
                at HttpContextReceivedAsyncResult`1.ProcessHttpContextAsync()  ilOffset = 0x9B
                at HttpChannelListener`1.BeginHttpContextReceived(HttpRequestContext context, Action acceptorCallback, AsyncCallback callback, Object state)  ilOffset = 0x0
                at HostedHttpTransportManager.HttpContextReceived(HostedHttpRequestAsyncResult result)  ilOffset = 0x62
                at HostedHttpRequestAsyncResult.HandleRequest()  ilOffset = 0x10E
                at HostedHttpRequestAsyncResult.BeginRequest()  ilOffset = 0x0
                at HostedHttpRequestAsyncResult.OnBeginRequest(Object state)  ilOffset = 0x9
                at AspNetPartialTrustHelpers.PartialTrustInvoke(ContextCallback callback, Object state)  ilOffset = 0x20
                at HostedHttpRequestAsyncResult.OnBeginRequestWithFlow(Object state)  ilOffset = 0x25
                at ScheduledOverlapped.IOCallback(UInt32 errorCode, UInt32 numBytes, NativeOverlapped* nativeOverlapped)  ilOffset = 0x22
                at IOCompletionThunk.UnhandledExceptionFrame(UInt32 error, UInt32 bytesRead, NativeOverlapped* nativeOverlapped)  ilOffset = 0x5
                at _IOCompletionCallback.PerformIOCompletionCallback(UInt32 errorCode, UInt32 numBytes, NativeOverlapped* pOVERLAP)  ilOffset = 0x1E
>Crm Exception: Message: No S2STokenIssuer certificate present in config database., ErrorCode: -2147220970
[2016-09-08 14:48:07.134] Process: w3wp |Organization:00000000-0000-0000-0000-000000000000 |Thread:   10 |Category: Platform.Sdk |User: 00000000-0000-0000-0000-000000000000 |Level: Error |ReqId: 20c4d076-0e42-4c90-b064-dc9e3ed603f2 | TraceSource.TraceData  ilOffset = 0x68
>http://msdn.microsoft.com/en-US/library/System.ServiceModel.Diagnostics.TraceHandledException.aspxHandling an exception. Exception details: Microsoft.Crm.CrmException: No S2STokenIssuer certificate present in config database.
>   at Microsoft.Crm.CrmException.Assert(Boolean condition, String message)
>   at Microsoft.Crm.Extensibility.MetadataEndpointServiceUtility.GetSigningCertificates()
>   at Microsoft.Crm.Extensibility.MetadataEndpointService.GenerateMetadata(String orgName)
>   at SyncInvokeGenerateMetadata(Object , Object[] , Object[] )
>   at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]& outputs)
>   at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc& rpc)
>   at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc& rpc)
>   at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc& rpc)
>   at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet)/LM/W3SVC/2/ROOT-1-131177908824467939Microsoft.Crm.CrmException, Microsoft.Crm.Core, Version=8.0.0.0, Culture=neutral, PublicKeyToken=31bf3856ad364e35No S2STokenIssuer certificate present in config database.   at Microsoft.Crm.CrmException.Assert(Boolean condition, String message)
>   at Microsoft.Crm.Extensibility.MetadataEndpointServiceUtility.GetSigningCertificates()
>   at Microsoft.Crm.Extensibility.MetadataEndpointService.GenerateMetadata(String orgName)
>   at SyncInvokeGenerateMetadata(Object , Object[] , Object[] )
>   at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]&amp; outputs)
>   at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc&amp; rpc)
>   at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc&amp; rpc)
>   at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc&amp; rpc)
>   at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet)Microsoft.Crm.CrmException: No S2STokenIssuer certificate present in config database.
>   at Microsoft.Crm.CrmException.Assert(Boolean condition, String message)
>   at Microsoft.Crm.Extensibility.MetadataEndpointServiceUtility.GetSigningCertificates()
>   at Microsoft.Crm.Extensibility.MetadataEndpointService.GenerateMetadata(String orgName)
>   at SyncInvokeGenerateMetadata(Object , Object[] , Object[] )
>   at System.ServiceModel.Dispatcher.SyncMethodInvoker.Invoke(Object instance, Object[] inputs, Object[]&amp; outputs)
>   at System.ServiceModel.Dispatcher.DispatchOperationRuntime.InvokeBegin(MessageRpc&amp; rpc)
>   at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage5(MessageRpc&amp; rpc)
>   at System.ServiceModel.Dispatcher.ImmutableDispatchRuntime.ProcessMessage11(MessageRpc&amp; rpc)
>   at System.ServiceModel.Dispatcher.MessageRpc.Process(Boolean isOperationContextSet)


 
hope this will help, though this was a stupid mistake to miss one step and being crazy with the error..


Regards,
Yes.Sudhanshu