Hi Kimj,
Thanks for the response.
Now I understand the difference between probing and other Devforce activities and it appears that my startup probing "alone" is only 1 second.
Here's my debuglog from Server, as you can see below when I initiate a query using my ContextManagerBase class, it has some amount of delay as well as the saving process.
Can you help me optimized this?
Note that I don't have any customized CompositionContext used here.
<?xml version="1.0"?><?xml-stylesheet href="DebugLog.xsl" type="text/xsl"?><log>
<entry id="10" timestamp="2011-10-10T16:32:44" username="" source="IdeaBlade.Core.TraceFileXmlLogger:GetLogHeader">------------ Log Created ------------</entry>
<entry id="0" timestamp="2011-10-10T16:32:42" username="" source="IdeaBlade.Core.IdeaBladeConfig:Initialize">Initializing configuration ...</entry>
<entry id="1" timestamp="2011-10-10T16:32:42" username="" source="IdeaBlade.Core.Composition.PartsCatalog:LoadCatalog">MEF assembly probing started: 10/10/2011 4:32:42 PM. If this takes a long time, use IdeaBlade.Core.Composition.CompositionHost to specify/restrict which assemblies to probe.</entry>
<entry id="2" timestamp="2011-10-10T16:32:42" username="" source="IdeaBlade.Core.Composition.PartsCatalog:LoadCatalog">Assembly 'iRely.ConnectionManager, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null' added to PartsCatalog</entry>
<entry id="3" timestamp="2011-10-10T16:32:43" username="" source="IdeaBlade.Core.Composition.PartsCatalog:LoadCatalog">MEF assembly probing completed: 10/10/2011 4:32:43 PM</entry>
<entry id="4" timestamp="2011-10-10T16:32:43" username="" source="IdeaBlade.Core.Composition.CompositionHost:.ctor">Probe Assemblies: iRely.ConnectionManager, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null :: iRely.VisionCore.Model, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null If this list is unnecessarily large, use CompositionHost.SearchPatterns to modify the search critieria for probed assemblies. If this list does not contain the assembly(ies) holding your a) domain model, b) custom interface implementations, and c) POCO/known types then your application may not work correctly. Ensure that these assemblies are available in the exe/bin folder, and if using CompositionHost.SearchPatterns that the patterns are set appropriately.</entry>
<entry id="5" timestamp="2011-10-10T16:32:43" username="" source="IdeaBlade.Core.IdeaBladeConfig:InitializationStatusCallback">IdeaBlade License: 'EnterpriseUniv', KeyDate: 9/19/2011, AllowedSessions: 10000. Found on Assembly: 'iRely.VisionCore.Model, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null'</entry>
<entry id="6" timestamp="2011-10-10T16:32:43" username="" source="IdeaBlade.Core.Configuration.ServerSettingsElement:ConstrainSettingsBasedOnLicenseCore">The configured SupportedClientApplicationType is Both</entry>
<entry id="7" timestamp="2011-10-10T16:32:43" username="" source="IdeaBlade.Core.Configuration.ServerSettingsElement:ConstrainSettingsBasedOnLicenseCore">Could not find a valid license to enable session-agnostic load balancing.</entry>
<entry id="8" timestamp="2011-10-10T16:32:44" username="" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for non-default 'ITraceLoggerProvider' and found no matching exports.</entry>
<entry id="9" timestamp="2011-10-10T16:32:44" username="" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for default 'ITraceLoggerProvider' and found 'IdeaBlade.Core.DefaultLoggerProvider'.</entry>
<entry id="11" timestamp="2011-10-10T16:32:44" username="" source="IdeaBlade.Core.TraceFns:CompleteTracingInitialization">IdeaBladeConfig resolution: File: D:\70_VisionCore\iRely Applications\iRely.VisionCore.BusinessObjectServer\web.config - found</entry>
<entry id="12" timestamp="2011-10-10T16:32:44" username="" source="IdeaBlade.Core.TraceFns:CompleteTracingInitialization">IdeaBladeConfig resolution: Logging file: D:\70_VisionCore\iRely Applications\iRely.VisionCore.BusinessObjectServer\log\DebugLog.xml</entry>
<entry id="13" timestamp="2011-10-10T16:32:44" username="" source="IdeaBlade.Core.TraceFns:CompleteTracingInitialization">Bound to .NET runtime version 4.0.30319.225</entry>
<entry id="14" timestamp="2011-10-10T16:32:44" username="" source="IdeaBlade.Core.TraceFns:CompleteTracingInitialization">DevForce version 6.1.2.0</entry>
<entry id="15" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.EntityModel.Server.EntityServiceHost:AddBehaviors">Using DC serializer for EntityService</entry>
<entry id="16" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for any 'ServiceHostEvents' and found 'IdeaBlade.EntityModel.Server.ServiceHostEvents'.</entry>
<entry id="17" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.EntityModel.Server.EntityServiceHostFactory:CreateServiceHost">EntityService listening on http://ivon.comtech.com/iRely.VisionCore.BusinessObjectServer/EntityService_VisionCoreOriginalHere.svc</entry>
<entry id="18" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for any 'EntityServiceApplication' and found 'IdeaBlade.EntityModel.EntityServiceApplication'.</entry>
<entry id="19" timestamp="2011-10-10T16:32:50" username="" source=":CreateIdeaBlade.EntityModel.Server.RemoteEntityService">EntityService created</entry>
<entry id="20" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.EntityModel.Server.EntityServer:.ctor">EntityServer created for DataSourceExtension: VisionCoreOriginalHere, CompositionContext: -IbDefault-</entry>
<entry id="21" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for any 'IEntityQueryExecutor' and found 'IdeaBlade.EntityModel.Edm.EdmQueryExecutor'.</entry>
<entry id="22" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for any 'IEntityQueryExecutor' and found 'IdeaBlade.EntityModel.Edm.PassthruEsqlQueryExecutor'.</entry>
<entry id="23" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for any 'IEntityQueryExecutor' and found 'IdeaBlade.EntityModel.Edm.StoredProcQueryExecutor'.</entry>
<entry id="24" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for any 'IEntityQueryExecutor' and found 'IdeaBlade.EntityModel.Edm.UdtQueryExecutor'.</entry>
<entry id="25" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.EntityModel.Server.SessionManager:GetLoginManager">Anonymous access: disabled</entry>
<entry id="26" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for non-default 'IEntityLoginManager' and found 'iRely.ConnectionManager.ConnectionSecurityIEntityLoginManager'.</entry>
<entry id="27" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for non-default 'IKnownTypeProvider' and found no matching exports.</entry>
<entry id="28" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.EntityModel.Server.EntityServerHost:<AddBehaviors>b__2">Using DC serializer for EntityServer</entry>
<entry id="29" timestamp="2011-10-10T16:32:50" username="" source="IdeaBlade.EntityModel.Server.EntityServerHostFactory:CreateServiceHost">EntityServer_VisionCoreOriginalHere listening on http://ivon.comtech.com/iRely.VisionCore.BusinessObjectServer/EntityServer_VisionCoreOriginalHere.svc</entry>
<entry id="30" timestamp="2011-10-10T16:32:53" username="ContextManagerBase" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for any 'EntityServerQueryInterceptor' and found 'iRely.ConnectionManager.EntityServerQueryManager'.</entry>
<entry id="31" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblSMSearch])</entry>
<entry id="32" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for default 'IDataSourceKeyResolver' and found 'IdeaBlade.EntityModel.DefaultDataSourceKeyResolver'.</entry>
<entry id="33" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for non-default 'IDataSourceKeyResolver' and found 'iRely.ConnectionManager.CustomDataSourceKeyResolver'.</entry>
<entry id="34" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for any 'IIdGenerator' and found 'IdeaBlade.EntityModel.StoreGeneratedIdGenerator'.</entry>
<entry id="35" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for non-default 'IConcurrencyStrategy' and found no matching exports.</entry>
<entry id="36" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for default 'IConcurrencyStrategy' and found 'IdeaBlade.EntityModel.DefaultConcurrencyValueSetter'.</entry>
<entry id="37" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.EntityModel.Edm.EdmKey:FindClientAssembly">DataSourceKey probing started at 10/10/2011 4:32:54 PM</entry>
<entry id="38" timestamp="2011-10-10T16:32:54" username="ContextManagerBase" source="IdeaBlade.EntityModel.Edm.EdmKey:FindClientAssembly">DataSourceKey: 'VisionCoreEntities_VisionCoreOriginalHere' found in assembly 'iRely.VisionCore.Model, Version=1.0.0.0, Culture=neutral, PublicKeyToken=null' at 10/10/2011 4:32:54 PM</entry>
<entry id="39" timestamp="2011-10-10T16:33:02" username="" source="IdeaBlade.EntityModel.EntityServerProxy:CreateInstance">Loaded IdeaBlade.EntityModel.EntityServerProxy</entry>
<entry id="40" timestamp="2011-10-10T16:33:02" username="ContextManagerBase" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblSMSearch]).Where(p => ((p.strTableName == "tblARCustomer") AndAlso (p.intSecurityUserID == 1)))</entry>
<entry id="41" timestamp="2011-10-10T16:33:02" username="" source="IdeaBlade.Core.DynamicTypeInfo:get_DynamicType">DynamicType constructed _IB_ivGLpM86vXHw6uJ6</entry>
<entry id="42" timestamp="2011-10-10T16:33:02" username="ContextManagerBase" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblARCustomer]).Select(t => new _IB_ivGLpM86vXHw6uJ6() {intCustomerID = t.intCustomerID, strAddress = t.strAddress, strCity = t.strCity, strCompanyName = t.strCompanyName, strCustomerID = t.strCustomerID, strCustomerType = t.strCustomerType, strEmail = t.strEmail, strFirstName = t.strFirstName, strLastName = t.strLastName, strPhone = t.strPhone, strSalesperson = t.strSalesperson, strState = t.strState, strZip = t.strZip, ysnAcceptBO = t.ysnAcceptBO, ysnActive = t.ysnActive}).Count()</entry>
<entry id="43" timestamp="2011-10-10T16:33:03" username="ContextManagerBase" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblARCustomer]).Select(t => new _IB_ivGLpM86vXHw6uJ6() {intCustomerID = t.intCustomerID, strAddress = t.strAddress, strCity = t.strCity, strCompanyName = t.strCompanyName, strCustomerID = t.strCustomerID, strCustomerType = t.strCustomerType, strEmail = t.strEmail, strFirstName = t.strFirstName, strLastName = t.strLastName, strPhone = t.strPhone, strSalesperson = t.strSalesperson, strState = t.strState, strZip = t.strZip, ysnAcceptBO = t.ysnAcceptBO, ysnActive = t.ysnActive}).OrderBy(Param_0 => Param_0.intCustomerID)</entry>
<entry id="44" timestamp="2011-10-10T16:33:07" username="ContextManager" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblARCustomer]).Where(p => True).OrderByDescending(t => t.intCustomerID).Count()</entry>
<entry id="45" timestamp="2011-10-10T16:33:07" username="ContextManager" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblARCustomer]).Where(p => True).OrderByDescending(t => t.intCustomerID).Take(25)</entry>
<entry id="46" timestamp="2011-10-10T16:33:08" username="ContextManager" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblARCustomer]).Where(t => (t.intCustomerID == 38)).OfType().SelectMany(t => t.tblARCustomerContacts)</entry>
<entry id="47" timestamp="2011-10-10T16:33:08" username="ContextManager" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblSMShipVia]).Where(t => (t.intShipViaID == 4))</entry>
<entry id="48" timestamp="2011-10-10T16:33:08" username="ContextManager" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblARTaxCode]).Where(t => (t.intTaxCodeID == 88))</entry>
<entry id="49" timestamp="2011-10-10T16:33:09" username="ContextManager" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblSMTerm]).Where(t => (t.intTermID == 3))</entry>
<entry id="50" timestamp="2011-10-10T16:33:09" username="ContextManager" source="IdeaBlade.EntityModel.Server.EntityServerQueryInterceptor:ExecuteQuery">Fetch ... value(IdeaBlade.EntityModel.EntityQueryProxy`1[iRely.VisionCore.Model.tblARTaxCode]).Where(t => (t.intTaxCodeID == 88))</entry>
between here I initiated a save process.. More or less 2011-10-10T16:33:10 or 11
<entry id="51" timestamp="2011-10-10T16:33:15" username="" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for any 'ICompositionContextResolver' and found no matching exports.</entry>
<entry id="52" timestamp="2011-10-10T16:33:16" username="ContextManager" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for any 'EntityServerSaveInterceptor' and found 'iRely.ConnectionManager.EntityServerSaveManager'.</entry>
<entry id="53" timestamp="2011-10-10T16:33:16" username="ContextManager" source="IdeaBlade.Core.Composition.CompositionHost:CheckMultiExport">CompositionContext: '-IbDefault-' - Probed for non-default 'IVerifierProvider' and found no matching exports.</entry>
<entry id="54" timestamp="2011-10-10T16:33:16" username="ContextManager" source="IdeaBlade.Core.Composition.CompositionHost:GetImportDefSingle">CompositionContext: '-IbDefault-' - Probed for any 'IEdmSaveExecutor' and found 'IdeaBlade.EntityModel.Edm.EdmSaveExecutor'.</entry>
</log>
Thanks,
Von