Running in Terminal Services session... Monitoring debug output from processes running in the console session Monitoring debug output from processes running in the current Terminal Services session 3 14:17:02.685 [2228] (EVIndexAdminService) <3528> EV-M {VelocityProcessHealthMonitor.CheckProcessPriority} VelocityProcessPriorityMonitor is performing it's periodic check of process priorities 4 14:17:05.950 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskQueue} TraceTimer [59999ms] BlockingDequeue: Semaphore.Wait 5 14:17:05.950 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskQueue} BlockingDequeue: Timed out waiting for a task. 6 14:17:05.950 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskThread} TraceTimer [60000ms] ThreadMain: taskQueue.Dequeue 7 14:17:05.950 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskProcessor} IdleTimeoutReached: At minimum threads, so telling thread to keep running. ThreadCount=2 8 14:17:05.950 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskThread} ThreadMain: No tasks available, but told to stick around, so will go back to waiting for task. 9 14:17:06.028 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskQueue} TraceTimer [60000ms] BlockingDequeue: Semaphore.Wait 10 14:17:06.028 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskQueue} BlockingDequeue: Timed out waiting for a task. 11 14:17:06.028 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskThread} TraceTimer [60000ms] ThreadMain: taskQueue.Dequeue 12 14:17:06.028 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskProcessor} IdleTimeoutReached: At minimum threads, so telling thread to keep running. ThreadCount=2 13 14:17:06.028 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskThread} ThreadMain: No tasks available, but told to stick around, so will go back to waiting for task. 14 14:17:07.075 [4292] (w3wp) <7824> EV:L CIndexSearch2::Reset 15 14:17:07.075 [4292] (w3wp) <7824> EV:L CIndexSearch2::FinalRelease 16 14:17:07.075 [4292] (w3wp) <7824> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 0 17 14:17:07.075 [4292] (w3wp) <7824> EV:L {CClientAuthenticate::GenAuthString:#361} Generating auth string... 20 14:17:07.075 [4292] (w3wp) <7824> EV:M ClientAuthHelperImpl::GenAuthString Authentication Type: Currently impersonated user Client:(null) ==> AuthToken:RMNETEV01.MyDomain.lan U5U6***** 22 14:17:07.075 [4292] (w3wp) <7824> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 23 14:17:07.075 [4292] (w3wp) <7824> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 24 14:17:07.153 [4292] (w3wp) <7824> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 10854320 26 14:17:07.169 [4292] (w3wp) <7824> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 27 14:17:07.169 [4292] (w3wp) <7824> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 28 14:17:07.185 [4292] (w3wp) <7824> EV:L {VaultCoCreateInstanceEx} CLSID [{4EC6FF76-C97A-11D1-90E0-0000F879BE6A}] Server Name [(null)] Used Server Name [(null)] Num of attempts [1] Total elapsed [0.000s] Result [Success (0)] 29 14:17:07.185 [4292] (w3wp) <7824> EV:L Currently shopping for: MyDomain\MyUsername |For more information, see Help and Support Center at http://entced.symantec.com/entt?product=ev&language=english&version=11.0.1.0&build=11.0.1.3683&error=V-437-5120 32 14:17:07.185 [4292] (w3wp) <7824> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 33 14:17:07.185 [4292] (w3wp) <7824> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 34 14:17:07.294 [5764] (w3wp) <5896> EV-H {WebAppCulture.SetCurrentThreadCulture} Checking language code it-it 35 14:17:07.294 [5764] (w3wp) <5896> EV-H {WebAppCulture.IsLanguageSupported} Language code it-it is not supported 36 14:17:07.294 [5764] (w3wp) <4092> EV-L {EVS} Auth Type Token 'Negotiate' found. User is windows impersonated user. || User: MyDomain\MyUsername 37 14:17:07.294 [5764] (w3wp) <5896> EV-H {WebAppCulture.SetCurrentThreadCulture} Checking language code it 38 14:17:07.294 [5764] (w3wp) <4092> EV-L {EVS} Done with authentication || User: MyDomain\MyUsername 39 14:17:07.294 [5764] (w3wp) <5896> EV-H {WebAppCulture.IsLanguageSupported} Language code it is supported 40 14:17:07.294 [5764] (w3wp) <5896> EV-L {WebAppCulture.SetCurrentThreadCulture} Culture set for it 50 14:17:11.060 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 51 14:17:11.060 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentManagementService::GetGeneralSettings() || User: MyDomain\MyUsername 52 14:17:11.060 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentSource::GetGeneralSettings() || User: MyDomain\MyUsername 53 14:17:11.060 [5764] (w3wp) <4092> EV-L {EVS} End ContentSource::GetGeneralSettings() || User: MyDomain\MyUsername 54 14:17:11.060 [5764] (w3wp) <4092> EV-L {EVS} End ContentManagementService::GetGeneralSettings() || User: MyDomain\MyUsername 55 14:17:11.060 [5764] (w3wp) <4092> EV-L {EVS} ShellPresenter : Loading UserSettings || User: MyDomain\MyUsername 56 14:17:11.060 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentManagementService::GetUserSettings() || User: MyDomain\MyUsername 57 14:17:11.060 [5764] (w3wp) <4092> EV-L {EVS} Begin PreferenceConfigurator::Load() || User: MyDomain\MyUsername 58 14:17:11.060 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 59 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} Preferences loaded. || User: MyDomain\MyUsername 60 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} End PreferenceConfigurator::Load() || User: MyDomain\MyUsername 61 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} Start Common::GetUserPolicySettingsFromXmlString() || User: MyDomain\MyUsername 62 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} Started parsing of User Policy Xml string: || User: MyDomain\MyUsername 63 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} Completed parsing of User Policy Xml string. || User: MyDomain\MyUsername 64 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} End Common::GetUserPolicySettingsFromXmlString() || User: MyDomain\MyUsername 65 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} End ContentManagementService::GetUserSettings() || User: MyDomain\MyUsername 66 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} ShellPresenter : End Loading UserSettings || User: MyDomain\MyUsername 67 14:17:11.122 [5764] (w3wp) <4092> EV-L {EVS} before getting the display name for the user || User: MyDomain\MyUsername 68 14:17:12.685 [2228] (EVIndexAdminService) <3528> EV-M {VelocityProcessHealthMonitor.CheckProcessPriority} VelocityProcessPriorityMonitor is performing it's periodic check of process priorities 69 14:17:18.669 [2228] (EVIndexAdminService) <3528> EV-L {ProcessManager.LeaseRenewal} Renewing the lease of the object EV Index Volumes Processor. Current state of lease: Active 70 14:17:18.700 [2228] (EVIndexAdminService) <3528> EV-L {ProcessManager.LeaseRenewal} Renewing the lease of the object EV Index Query Server. Current state of lease: Active 75 14:17:21.716 [428] (EVIndexQueryServer) <3860> EV-L {SearchTaskGarbageCollector} TraceTimer [7ms] GC Collect and WaitForPendingFinalizers 78 14:17:22.700 [2228] (EVIndexAdminService) <3528> EV-M {VelocityProcessHealthMonitor.CheckProcessPriority} VelocityProcessPriorityMonitor is performing it's periodic check of process priorities 79 14:17:22.779 [4292] (w3wp) <5752> EV:L CIndexSearch2::Reset 80 14:17:22.779 [4292] (w3wp) <5752> EV:L CIndexSearch2::FinalRelease 81 14:17:22.779 [4292] (w3wp) <5752> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 0 82 14:17:22.779 [4292] (w3wp) <5752> EV:L {CClientAuthenticate::GenAuthString:#361} Generating auth string... 83 14:17:22.779 [4292] (w3wp) <5752> EV:M ClientAuthHelperImpl::GenAuthString Authentication Type: Currently impersonated user Client:(null) ==> AuthToken:RMNETEV01.MyDomain.lan YpWR***** 85 14:17:22.779 [4292] (w3wp) <5752> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 86 14:17:22.779 [4292] (w3wp) <5752> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 87 14:17:22.857 [4292] (w3wp) <5752> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 10854320 89 14:17:22.857 [4292] (w3wp) <5752> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 90 14:17:22.857 [4292] (w3wp) <5752> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 91 14:17:22.872 [4292] (w3wp) <5752> EV:L {VaultCoCreateInstanceEx} CLSID [{4EC6FF76-C97A-11D1-90E0-0000F879BE6A}] Server Name [(null)] Used Server Name [(null)] Num of attempts [1] Total elapsed [0.000s] Result [Success (0)] 92 14:17:22.872 [4292] (w3wp) <5752> EV:L Currently shopping for: MyDomain\evadmin |For more information, see Help and Support Center at http://entced.symantec.com/entt?product=ev&language=english&version=11.0.1.0&build=11.0.1.3683&error=V-437-5120 95 14:17:22.872 [4292] (w3wp) <5752> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 96 14:17:22.872 [4292] (w3wp) <5752> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 97 14:17:22.904 [5764] (w3wp) <4092> EV-L {EVS} Auth Type Token 'Negotiate' found. User is windows impersonated user. || User: MyDomain\evadmin 98 14:17:22.904 [5764] (w3wp) <4092> EV-L {EVS} Done with authentication || User: MyDomain\evadmin 99 14:17:22.904 [5764] (w3wp) <5900> EV-L {WebAppCulture.SetCurrentThreadCulture} Culture set for en 124 14:17:32.716 [2228] (EVIndexAdminService) <2296> EV-M {VelocityProcessHealthMonitor.CheckProcessPriority} VelocityProcessPriorityMonitor is performing it's periodic check of process priorities 139 14:17:42.732 [2228] (EVIndexAdminService) <2296> EV-M {VelocityProcessHealthMonitor.CheckProcessPriority} VelocityProcessPriorityMonitor is performing it's periodic check of process priorities 142 14:17:52.748 [2228] (EVIndexAdminService) <3528> EV-M {VelocityProcessHealthMonitor.CheckProcessPriority} VelocityProcessPriorityMonitor is performing it's periodic check of process priorities 147 14:17:57.326 [5764] (w3wp) <5896> EV:L {CClientAuthenticate::GenAuthString:#361} Generating auth string... 148 14:17:57.326 [5764] (w3wp) <4092> EV-L {EVS} after getting the display name for the user || User: MyDomain\MyUsername 149 14:17:57.326 [5764] (w3wp) <4092> EV-L {EVS} User: Name Surname Logged in from browser Mozilla/4.0 (compatible; MSIE 7.0; Windows NT 10.0; WOW64; Trident/8.0; .NET4.0C; .NET4.0E; .NET CLR 2.0.50727; .NET CLR 3.0.30729; .NET CLR 3.5.30729; InfoPath.3): || User: MyDomain\MyUsername 150 14:17:57.326 [5764] (w3wp) <4092> EV-L {EVS} ArchivesPresenter.LoadArchiveGroups : Start GetArchiveGroups : || User: MyDomain\MyUsername 151 14:17:57.326 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentManagementService::GetArchiveGroups() || User: MyDomain\MyUsername 152 14:17:57.326 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentSource::GetArchiveGroups() || User: MyDomain\MyUsername 153 14:17:57.326 [5764] (w3wp) <4092> EV-L {EVS} Before ContentSource::GetArchiveGroups() GetNextLevelArchiveXML || User: MyDomain\MyUsername 156 14:17:57.326 [5764] (w3wp) <5896> EV:M ClientAuthHelperImpl::GenAuthString Authentication Type: Currently impersonated user Client:(null) ==> AuthToken:RMNETEV01.MyDomain.lan hZWE***** 158 14:17:57.341 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 159 14:17:57.341 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 160 14:17:57.388 [5764] (w3wp) <5896> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 10854320 161 14:17:57.404 [5764] (w3wp) <5896> EV:L {CClientAuthenticate::GenAuthString:#361} Generating auth string... 162 14:17:57.404 [5764] (w3wp) <5896> EV:M ClientAuthHelperImpl::GenAuthString Authentication Type: Currently impersonated user Client:(null) ==> AuthToken:RMNETEV01.MyDomain.lan hZXS***** 163 14:17:57.404 [5764] (w3wp) <4092> EV-L {EVS} After ContentSource::GetArchiveGroups() GetNextLevelArchiveXML || User: MyDomain\MyUsername 165 14:17:57.404 [5764] (w3wp) <4092> EV-L {EVS} Before ContentSource::XDocument.Parse || User: MyDomain\MyUsername 166 14:17:57.404 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 167 14:17:57.404 [5764] (w3wp) <4092> EV-L {EVS} After ContentSource::XDocument.Parse || User: MyDomain\MyUsername 168 14:17:57.404 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 169 14:17:57.404 [5764] (w3wp) <4092> EV-L {EVS} After ContentSource::fetch distinct types || User: MyDomain\MyUsername 170 14:17:57.404 [5764] (w3wp) <4092> EV-L {EVS} Including extended type : 597EC7E0-B36C-4C94-8891-509754ABEA76 || User: MyDomain\MyUsername 171 14:17:57.404 [5764] (w3wp) <4092> EV-L {EVS} Before calling GetArchives for the default archive groups. || User: MyDomain\MyUsername 172 14:17:57.419 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentSource::GetArchives() || User: MyDomain\MyUsername 173 14:17:57.419 [5764] (w3wp) <4092> EV-L {EVS} Archive Query type: 597EC7E0-B36C-4C94-8891-509754ABEA76|CD66FCBB-7840-4237-AB95-816F77D484E8|7F42F29F-0FB8-47C0-A438-00D62081609F| ,startindex: 0 ,totalrecordcount: 2147483647 || User: MyDomain\MyUsername 175 14:17:57.466 [5764] (w3wp) <5896> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 10854320 176 14:17:57.466 [5764] (w3wp) <5896> EV:L {CContentManagementAPI::CreateInternalObject:#1151} Type: class CArchiveFolders 177 14:17:57.466 [5764] (w3wp) <5896> EV:L CContentManagementAPI::TransformAuthenticationIdentity AuthenticationTypeIdentity is WindowsUser and no Identity set - defaulting to '.' (current user) 178 14:17:57.466 [5764] (w3wp) <5896> EV:L CAuthHelper::GenAuthString Authenticate using current user via DCOM 180 14:17:57.466 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 181 14:17:57.466 [5764] (w3wp) <5896> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 183 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} ContentSource::GetArchives() Archive: [Name Surname], IndexVolumeCount: [1] || User: MyDomain\MyUsername 184 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} Total Archives: [1] || User: MyDomain\MyUsername 185 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} End ContentSource::GetArchives() || User: MyDomain\MyUsername 186 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} After calling GetArchives for the default archive groups. || User: MyDomain\MyUsername 187 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} End ContentSource::GetArchiveGroups() || User: MyDomain\MyUsername 188 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} End ContentManagementService::GetArchiveGroups() || User: MyDomain\MyUsername 189 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} ArchivesPresenter.LoadArchiveGroups : End GetArchiveGroups : || User: MyDomain\MyUsername 190 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentManagementService::GetFolderHeirarchy() || User: MyDomain\MyUsername 191 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentSource::GetFolderHeirarchy() for Archive || User: MyDomain\MyUsername 192 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} Folder Query Archive type: [597EC7E0-B36C-4C94-8891-509754ABEA76], Folder ID: [], Archive ID: [1520CBE2F4F0289438B76222DAECC9B8D1110000archiving], Is Subfolder ID: [False], Start index: [0], TotalRecordCount: [0] || User: MyDomain\MyUsername 193 14:17:57.466 [5764] (w3wp) <4092> EV-L {EVS} ContentSource::GetFolderHeirarchy() FolderId to expand: [19930251F8B7CD64D902D6E5504F3925B1110000archiving], Startup location type: [LastAccessed] || User: MyDomain\MyUsername 194 14:17:57.544 [5764] (w3wp) <5896> EV:L {VaultCoCreateInstanceEx} CLSID [{4EC6FF76-C97A-11D1-90E0-0000F879BE6A}] Server Name [(null)] Used Server Name [(null)] Num of attempts [1] Total elapsed [0.000s] Result [Success (0)] 195 14:17:57.544 [5764] (w3wp) <5896> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 0 196 14:17:57.544 [5764] (w3wp) <5896> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 0 197 14:17:57.544 [5764] (w3wp) <5896> EV:L ICollectionBaseImpl,struct IDirectoryVault>::get_Count Count:7 Maximum:50000 Records:7 198 14:17:57.544 [5764] (w3wp) <5896> EV:L ICollectionBaseImpl,struct IDirectoryVault>::get__NewEnum Count:7 199 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::FinalConstruct() 200 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::Initialise() 201 14:17:57.544 [5764] (w3wp) <4092> EV-L {EVS} GetAllSubfolders() Archive folders count: [7] || User: MyDomain\MyUsername 202 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Entry) 203 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Exit) Status: [Success] 204 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::FinalConstruct() 205 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::Initialise() 206 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Entry) 207 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Exit) Status: [Success] 208 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::FinalConstruct() 209 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::Initialise() 210 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Entry) 211 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Exit) Status: [Success] 212 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::FinalConstruct() 213 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::Initialise() 214 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Entry) 215 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Exit) Status: [Success] 216 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::FinalConstruct() 217 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::Initialise() 218 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Entry) 219 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Exit) Status: [Success] 220 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::FinalConstruct() 221 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::Initialise() 222 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Entry) 223 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Exit) Status: [Success] 224 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::FinalConstruct() 225 14:17:57.544 [5764] (w3wp) <5896> EV:L CArchiveFolder::Initialise() 226 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Entry) 227 14:17:57.544 [5764] (w3wp) <5896> EV:L {CArchiveFolder::Load} (Exit) Status: [Success] 228 14:17:57.544 [5764] (w3wp) <4092> EV-L {EVS} ContentSource::GetFolderHeirarchy() sortedFolders count: [7], folderMap count: [7] || User: MyDomain\MyUsername 229 14:17:57.544 [5764] (w3wp) <4092> EV-L {EVS} ContentSource::GetFolderHeirarchy() foldersToReturn count: [5] || User: MyDomain\MyUsername 230 14:17:57.544 [5764] (w3wp) <4092> EV-L {EVS} End ContentSource::GetFolderHeirarchy() for Archive || User: MyDomain\MyUsername 231 14:17:57.544 [5764] (w3wp) <4092> EV-L {EVS} End ContentManagementService::GetFolderHeirarchy() || User: MyDomain\MyUsername 232 14:17:57.544 [5764] (w3wp) <4092> EV-L {EVS} ArchivesPresenter.LoadArchiveGroups : After Loading Archives: || User: MyDomain\MyUsername 233 14:17:57.544 [5764] (w3wp) <4092> EV-L {EVS} Export to Nsf feature is not allowed because either search policy setting for Nsf export is off or Notes client is not installed on the server. || User: MyDomain\MyUsername 236 14:17:59.154 [5764] (w3wp) <5828> EV:L {CClientAuthenticate::GenAuthString:#361} Generating auth string... 237 14:17:59.154 [5764] (w3wp) <5828> EV:M ClientAuthHelperImpl::GenAuthString Authentication Type: Currently impersonated user Client:(null) ==> AuthToken:RMNETEV01.MyDomain.lan h5Wo***** 238 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Start ClientDataService.GetSearchResults. || User: MyDomain\MyUsername 239 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} ResultsPluginBuilder.GetSearchResultsPlugin : Start Getting Search Plugin. ArchiveType = 597EC7E0-B36C-4C94-8891-509754ABEA76 || User: MyDomain\MyUsername 240 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} ResultsPluginBuilder.GetSearchResultsPlugin : End Getting Search Plugin. foldertype = Inbox, ArchiveType = 597EC7E0-B36C-4C94-8891-509754ABEA76 || User: MyDomain\MyUsername 241 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} ClientDataService.GetSearchResults : After GetSearchResults Plugin. || User: MyDomain\MyUsername 242 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} ClientDataService.GetSearchResults : Before GetSearchResults from Index Service. || User: MyDomain\MyUsername 243 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentManagementService::GetSearchResults() || User: MyDomain\MyUsername 244 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Begin SearchOrchestrator::GetSearchResults() || User: MyDomain\MyUsername 245 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Started conversion of EVS Search request to SOAP Search Request || User: MyDomain\MyUsername 246 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Started Converting EVS Search Input to SOAP Boolean text Query || User: MyDomain\MyUsername 247 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Completed Converting EVS Search Input to SOAP Boolean text Query || User: MyDomain\MyUsername 248 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Maximum Source To Federate for SOAP API: 0 || User: MyDomain\MyUsername 249 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Timezone offset received from UI: -60 || User: MyDomain\MyUsername 250 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Timezone info send to SOAP API: +01:00 || User: MyDomain\MyUsername 251 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Completed conversion of EVS Search request to SOAP Search Request || User: MyDomain\MyUsername 252 14:17:59.154 [5764] (w3wp) <4092> EV-L {EVS} Submitted to SOAP API with Boolean Text Query: pvid:19930251F8B7CD64D902D6E5504F3925B1110000archiving || User: MyDomain\MyUsername 253 14:17:59.279 [4348] (w3wp) <2084> EV-M {SOAP} -----> SOAP Search request received from user MyDomain\MyUsername 254 14:17:59.279 [4348] (w3wp) <2084> EV-L {SearchRequestContext} Set OriginalRequesUrl to net.tcp://localhost/EnterpriseVaultAPI/Search/SOAPSearch.svc 255 14:17:59.279 [4348] (w3wp) <2084> EV-L {WCFHeaders} Header EV_CACHE_CONTROL NOT not found in WCF headers. 256 14:17:59.279 [4348] (w3wp) <2084> EV-L {WCFHeaders} Header EV_AUTH_TOKEN not found in WCF headers. 257 14:17:59.279 [4348] (w3wp) <2084> EV-M {WcfAuthTokenScope} Auth token RMNETEV01.MyDomain.lan h5Wo***** found in incoming WCF headers. Will reuse this token for outgoing calls to IQS. 258 14:17:59.279 [4348] (w3wp) <2084> EV-M {QueryTracer} [1/1] Boolean text query:|pvid:19930251F8B7CD64D902D6E5504F3925B1110000archiving 259 14:17:59.279 [4348] (w3wp) <2084> EV-M {SearchTracking} [TRACKING] INCOMING SEARCH REQUEST ID=[7349c49f-3112-4885-b011-a57ea5dd310b] SOURCESERVER=unknown SOURCEPROCESS=unknown INDEXVOLUME=unknown 260 14:17:59.279 [4348] (w3wp) <2084> EV-L {SearchRequestContext} Set OriginalRequestedFields to msgcnatcauthsubjdatesizeppdnmsgcdtyppvidsnumvlidVault.MsgType 261 14:17:59.279 [4348] (w3wp) <2084> EV-L {SearchRequestContext} Set OrignalSortBy to datefalse 262 14:17:59.279 [4348] (w3wp) <2084> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 263 14:17:59.279 [4348] (w3wp) <2084> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 264 14:17:59.326 [4348] (w3wp) <2084> EV:L {VaultCoCreateInstanceEx} CLSID [{4EC6FF76-C97A-11D1-90E0-0000F879BE6A}] Server Name [(null)] Used Server Name [(null)] Num of attempts [1] Total elapsed [0.000s] Result [Success (0)] 265 14:17:59.326 [4348] (w3wp) <2084> EV:L CDirectoryVaultObject::GetAttributeListFromType Unknown type - EnumIndexVolumesByArchiveEx 266 14:17:59.326 [4348] (w3wp) <2084> EV-L {IndexVolumes} TraceTimer [48ms] directory.EnumIndexVolumesByArchiveEx 267 14:17:59.326 [4348] (w3wp) <2084> EV-L {IndexVolumes} GetIndexVolumesInfo from directory. 1 volumes for archive 1520CBE2F4F0289438B76222DAECC9B8D1110000archiving. 268 14:17:59.326 [4348] (w3wp) <2084> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 269 14:17:59.326 [4348] (w3wp) <2084> EV-L {SearchSanitiser} Added sort order snum ascending to caller-specified sorting, to break ties. 270 14:17:59.326 [4348] (w3wp) <2084> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 271 14:17:59.326 [4348] (w3wp) <2084> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 272 14:17:59.326 [4348] (w3wp) <2084> EV-L {MdsAvailability} MDS status is: EV_MDS_READY 273 14:17:59.326 [4348] (w3wp) <2084> EV-M {MdsAvailability} MDS is 'Ready' for archive with ID 1520CBE2F4F0289438B76222DAECC9B8D1110000archiving 274 14:17:59.326 [4348] (w3wp) <2084> EV-M {SearchClient} Search is compatible with MDS, so will try to retrieve results from MDS. 275 14:17:59.326 [4348] (w3wp) <2084> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 276 14:17:59.326 [4348] (w3wp) <2084> EV-M {SearchTracking} [TRACKING] OUTGOING SEARCH REQUEST ID=[7349c49f-3112-4885-b011-a57ea5dd310b] DESTINATIONSERVER=archiving.MyDomain.it DESTINATIONPROCESS=EVIndexQueryServer.exe INDEXVOLUME=-1 277 14:17:59.326 [4348] (w3wp) <2084> EV-L {WCFProxy`1} Calling BeginSearch 278 14:17:59.341 [4348] (w3wp) <2084> EV-L {WCFProxy`1} TraceTimer [6ms] Called BeginSearch 279 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-M {WCFSecurity} Incoming WCF call has Windows credentials - explicitly attaching credentials to thread. Previous Thread.Principal=IIS APPPOOL\EnterpriseVaultAPI, New Thread.Principal=IIS APPPOOL\EnterpriseVaultAPI 280 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-M {SOAP} -----> SOAP Search request received from user IIS APPPOOL\EnterpriseVaultAPI 281 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-L {WCFHeaders} Header SearchRequestContext not found in WCF headers. 282 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-L {SearchRequestContext} Get OrignalSortBy = datefalse 283 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-L {SearchRequestContext} Get OriginalRequesUrl = net.tcp://localhost/EnterpriseVaultAPI/Search/SOAPSearch.svc 284 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-L {WCFHeaders} Header EV_AUTH_TOKEN not found in WCF headers. 285 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-M {SOAPSearchHelpers} EV_AUTH_TOKEN from SOAP headers = RMNETEV01.MyDomain.lan h5Wo***** 286 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-M {SearchTracking} [TRACKING] INCOMING SEARCH REQUEST ID=[7349c49f-3112-4885-b011-a57ea5dd310b] SOURCESERVER=unknown SOURCEPROCESS=unknown INDEXVOLUME=unknown 287 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV-M {QueryTracer} [1/1] Boolean text query:|pvid:19930251F8B7CD64D902D6E5504F3925B1110000archiving (TimeZone=+01:00, DateFormatHints=dd/MM/yyyy, dddd d MMMM yyyy) 289 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 290 14:17:59.341 [428] (EVIndexQueryServer) <5156> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 291 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV:L {VaultCoCreateInstanceEx} CLSID [{4EC6FF76-C97A-11D1-90E0-0000F879BE6A}] Server Name [(null)] Used Server Name [(null)] Num of attempts [1] Total elapsed [0.000s] Result [Success (0)] 292 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV:L CDirectoryVaultObject::GetAttributeListFromType Unknown type - EnumIndexVolumesByArchiveEx 293 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {IndexVolumes} TraceTimer [42ms] directory.EnumIndexVolumesByArchiveEx 294 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {IndexVolumes} GetIndexVolumesInfo from directory. 1 volumes for archive 1520CBE2F4F0289438B76222DAECC9B8D1110000archiving. 295 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 296 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV:L {VaultCoCreateInstanceEx} CLSID [{4D5CA60E-4358-11D4-8687-0008C7DF84BC}] Server Name [RMNETEV01.MyDomain.lan] Used Server Name [RMNETEV01.MyDomain.lan] Num of attempts [1] Total elapsed [0.002s] Result [Success (0)] 297 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {UserPermissions} TraceTimer [4ms] authClient.ConfirmClientIdentity 298 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {UserPermissions} SetCallerIdentity: Caller is MyDomain\MyUsername 299 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 300 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {SearchTaskProcessor} AddThreadIfAppropriate: Threads=2, IdleThreads=2, TasksQueued=1, TasksQueuedForRetry=False 301 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-L {SearchTaskProcessor} AddThread: Thread count now 3 302 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-M {SearchTaskQueue} Enqueue: Enqueued small search 3 303 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskQueue} TraceTimer [53447ms] BlockingDequeue: Semaphore.Wait 304 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchTaskQueue} GetNextTask: NumSmallSearchesQueued=1, NumLargeSearchesQueued=0, NumTasksAssignedToThreads=0, NumTasksAssingedToThreadsForSmallSearches=0 305 14:17:59.388 [428] (EVIndexQueryServer) <5156> EV-M {SearchTaskProcessor} EnqueueTask: Enqueued task for search 3 306 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchTaskQueue} GetNextTask: Returning task from small search queue, search=3. 307 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskQueue} TraceTimer [0ms] BlockingDequeue: GetNextTask 308 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskThread} TraceTimer [53447ms] ThreadMain: taskQueue.Dequeue 309 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-H {SearchTask} Execute: Executing search 3 310 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {SourcesInUse} Add: Source 1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/-1 is in use. 1 total sources in use. 311 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [1/13] Starting command CloneRequestCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 312 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [1/13] Completed CloneRequestCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 313 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [2/13] Starting command CheckTimeoutCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 314 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {CheckTimeoutCommand} Search started at 08/02/2016 14:17:59, timeout is 00:10:00. 315 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [2/13] Completed CheckTimeoutCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 316 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [3/13] Starting command QueryTransformCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 317 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {QueryTransformCommand} QueryTransformCommand: Transforming from BooleanTextQuery to StructuredQuery 318 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {QueryTransformer} TraceTimer [0ms] TransformSearchRequest 319 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [3/13] Completed QueryTransformCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 320 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [4/13] Starting command StructuredTermTypeTransformCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 321 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [4/13] Completed StructuredTermTypeTransformCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 322 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [5/13] Starting command CalculatedFieldQueryTransformCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 323 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [5/13] Completed CalculatedFieldQueryTransformCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 324 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [6/13] Starting command FolderRestrictionQueryTransformCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 326 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 327 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 328 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {UserPermissions} IsCallerVSA: VSA is MyDomain\evadmin 329 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 330 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {UserSIDs} Got 25 sids for user MyDomain\MyUsername 331 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV-L {ArchivePermissions} First sid is S-1-5-21-350140609-3006545446-1311391614-4282 333 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 334 14:17:59.388 [428] (EVIndexQueryServer) <7344> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 335 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {ArchivePermissions} TraceTimer [66ms] dirPublic.GetArchiveOrArchiveFolderSecurity for 19930251F8B7CD64D902D6E5504F3925B1110000archiving 336 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {ArchivePermissions} TraceTimer [0ms] EVSecurityHelper.AccessCheck 337 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {ArchivePermissions} Caller MyDomain\MyUsername can search folder 19930251F8B7CD64D902D6E5504F3925B1110000archiving 338 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {QueryRestrictedToPermittedFoldersOptimisation} Query is restricted to 1 folder(s), all of which the caller has permission to search, so returning true. 339 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {FolderRestrictionQueryTransform} Archive is structured, but query is restricted to permitted folders, so no need to add further folder restrictions to the query. 340 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [69ms] [6/13] Completed FolderRestrictionQueryTransformCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 341 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [7/13] Starting command LogStructuredQueryCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 342 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [7/13] Completed LogStructuredQueryCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 343 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [8/13] Starting command BeginVaultStoreChecksCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 344 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {BeginVaultStoreChecksCommand} QueryOptions.CheckForMissingData is false, so not checking vault store db for missing items/content. 345 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [8/13] Completed BeginVaultStoreChecksCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 346 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [9/13] Starting command QueryTransformCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 347 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {QueryTransformCommand} QueryTransformCommand: Transforming from StructuredQuery to MdsQuery 348 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {QueryTransformer} TraceTimer [0ms] TransformSearchRequest 349 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [9/13] Completed QueryTransformCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 350 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [10/13] Starting command EngineSearchCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 351 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-M {QueryTracer} [Search 3] [1/1] MDS Query:|| false| true| false| | false| 19930251F8B7CD64D902D6E5504F3925B1110000archiving| | 352 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {DirectoryDBAccess.get_CommandTimeout} Using SQL CommandTimeout of 30 seconds 353 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {DirectoryDBAccess.get_CommandTimeout} Using SQL CommandTimeout of 30 seconds 354 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {SQLUtilities.InvokeSQLHelper} Calling Void b__0(). Reference: usp_BrowseMDSByFolder 355 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [198]. 356 14:17:59.466 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [325]. 357 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [234]. 358 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [209]. 359 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [230]. 360 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [495]. 361 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [400]. 362 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [426]. 363 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [352]. 364 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [366]. 365 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [356]. 366 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [309]. 367 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [245]. 368 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [244]. 369 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [409]. 370 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [431]. 371 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [266]. 372 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [321]. 373 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [399]. 374 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [334]. 375 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [297]. 376 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [315]. 377 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [214]. 378 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [297]. 379 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [331]. 380 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [327]. 381 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [196]. 382 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [339]. 383 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [304]. 384 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [325]. 385 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [440]. 386 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [381]. 387 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [300]. 388 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [381]. 389 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [453]. 390 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [312]. 391 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [304]. 392 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [257]. 393 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [323]. 394 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [190]. 395 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [191]. 396 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [196]. 397 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [361]. 398 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [431]. 399 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [366]. 400 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [255]. 401 14:17:59.482 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [256]. 402 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [186]. 403 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [234]. 404 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [236]. 405 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [300]. 406 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [202]. 407 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [238]. 408 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [305]. 409 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [306]. 410 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [339]. 411 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [335]. 412 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [285]. 413 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [403]. 414 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [194]. 415 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [205]. 416 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [346]. 417 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [232]. 418 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [201]. 419 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [324]. 420 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [515]. 421 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [504]. 422 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [491]. 423 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [300]. 424 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [203]. 425 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [263]. 426 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [255]. 427 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [231]. 428 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [245]. 429 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [478]. 430 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [345]. 431 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [397]. 432 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [356]. 433 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [445]. 434 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [365]. 435 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [372]. 436 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [311]. 437 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [313]. 438 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [213]. 439 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [383]. 440 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [239]. 441 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [394]. 442 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [414]. 443 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [253]. 444 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [298]. 445 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [174]. 446 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [173]. 447 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [307]. 448 14:17:59.498 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [302]. 449 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [292]. 450 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [254]. 451 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [343]. 452 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [218]. 453 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [235]. 454 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {XmlDecompressor} Decompressing XML blob. Size in bytes: [181]. 455 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {IndexVolumes} GetIndexVolumeInfo from cache: Name Surname/1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/1 456 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {CalculatedFieldsAdder} Will add calculated field vlid to results 457 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [45ms] [10/13] Completed EngineSearchCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 458 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [11/13] Starting command EndVaultStoreChecksCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 459 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {EndVaultStoreChecksCommand} TruncationReason: Expression evaluated to true after 0ms. 460 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {EndVaultStoreChecksCommand} TruncationReason = None 461 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [11/13] Completed EndVaultStoreChecksCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 462 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [12/13] Starting command ResultsTransformCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 463 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {ResultsTransformer} Results already in correct format. No transform required. 464 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {ResultsTransformer} TraceTimer [0ms] ResultsTransformer.Transform 465 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {ResultsTransformCommand} ResultsTransformCommand: Transformed results from SearchResults to SearchResults 466 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [12/13] Completed ResultsTransformCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 467 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} [13/13] Starting command AddOriginalQueryToResultsCommand for search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 468 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {QueryTransformer} TraceTimer [0ms] TransformSearchRequest 469 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-M {SearchPipeline} TraceTimer [0ms] [13/13] Completed AddOriginalQueryToResultsCommand, search 3, ID 7349c49f-3112-4885-b011-a57ea5dd310b, user MyDomain\MyUsername, source Name Surname (-1) 470 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {SourcesInUse} Remove: Source 1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/-1 is no longer in use. 0 total sources in use. 471 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV:L AuditInterface::AuditingEnabled() called 472 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV:L {CEVAudit::WillPerformAudit:#238} Determine whether to audit or not. 473 14:17:59.513 [428] (EVIndexQueryServer) <7344> EV-L {SearchTaskThread} TraceTimer [118ms] ThreadMain: Search execution has completed 474 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV:L {CEVAudit::WillPerformAudit:#336} Auditing is off, current status '1' 475 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV:L {CEVAudit::WillPerformAudit:#340} Deleting Audit Pool as auditing off. 476 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV:L {CEVAudit::WillPerformAudit:#342} Failed to delete auditing pool. 477 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV-L {SearchAudit} Skipping audit because auditing of searches is not enabled. 478 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV-M {SearchService} Returning 100 results (120 matches) for source 1520CBE2F4F0289438B76222DAECC9B8D1110000archiving/-1 479 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV-M {SearchTracking} [TRACKING] OUTGOING SEARCH RESPONSE ID=[7349c49f-3112-4885-b011-a57ea5dd310b] DESTINATIONSERVER=unknown DESTINATIONPROCESS=unknown INDEXVOLUME=unknown 480 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV-L {SoapSearchService} TraceTimer [168ms] SOAP request Search completed. 481 14:17:59.513 [428] (EVIndexQueryServer) <5156> EV-M {SOAP} <----- SOAP Search request completed successfully for user MyDomain\MyUsername 482 14:17:59.513 [4348] (w3wp) <2084> EV-L {WCFProxy`1} Calling EndSearch 483 14:17:59.529 [4348] (w3wp) <2084> EV-L {WCFProxy`1} TraceTimer [8ms] Called EndSearch 484 14:17:59.529 [4348] (w3wp) <2084> EV-M {SearchTracking} [TRACKING] INCOMING SEARCH RESPONSE ID=[7349c49f-3112-4885-b011-a57ea5dd310b] SOURCESERVER=archiving.MyDomain.it SOURCEPROCESS=EVIndexQueryServer.exe INDEXVOLUME=-1 485 14:17:59.529 [4348] (w3wp) <2084> EV-M {SearchTracking} [TRACKING] OUTGOING SEARCH RESPONSE ID=[7349c49f-3112-4885-b011-a57ea5dd310b] DESTINATIONSERVER=unknown DESTINATIONPROCESS=unknown INDEXVOLUME=unknown 486 14:17:59.529 [4348] (w3wp) <2084> EV-L {SOAPSearchService} TraceTimer [249ms] SOAP request Search completed. 487 14:17:59.529 [4348] (w3wp) <2084> EV-M {SOAP} <----- SOAP Search request completed successfully for user MyDomain\MyUsername 488 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} Received from SOAP API results count: 100 || User: MyDomain\MyUsername 489 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} Started conversion of SOAP API result to EVS Search result || User: MyDomain\MyUsername 490 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} Completed conversion of SOAP API result to EVS Search result || User: MyDomain\MyUsername 491 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} Received Search Results Truncate Parameters InSync: True, TruncationReasonEnumValue: 0 || User: MyDomain\MyUsername 492 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} End SearchOrchestrator::GetSearchResults() || User: MyDomain\MyUsername 493 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} End ContentManagementService::GetSearchResults() || User: MyDomain\MyUsername 494 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} ClientDataService.GetSearchResults : After GetSearchResults from Index Service. || User: MyDomain\MyUsername 495 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} ClientDataService.GetSearchResults : Before SearchResultsDataMapper.Map. || User: MyDomain\MyUsername 496 14:17:59.545 [5764] (w3wp) <4092> EV-L {EVS} ClientDataService.GetSearchResults : After SearchResultsDataMapper.Map. || User: MyDomain\MyUsername 498 14:17:59.716 [5764] (w3wp) <5828> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Entry [m_nNumTries = 40] 499 14:17:59.716 [5764] (w3wp) <4092> EV-L {EVS} Start ClientDataService=>SetStartupLocationPreference() Before SetUserPreference() || User: MyDomain\MyUsername 500 14:17:59.716 [5764] (w3wp) <5828> EV:L CBaseDirectoryServiceWrapper::CreateDirectoryService() - Successfully communicated with an EV Directory Service on the local machine 501 14:17:59.716 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentManagementService::SaveUserPreferences() || User: MyDomain\MyUsername 502 14:17:59.716 [5764] (w3wp) <4092> EV-L {EVS} Begin PreferenceConfigurator::Save() || User: MyDomain\MyUsername 503 14:17:59.732 [5764] (w3wp) <4092> EV-L {EVS} Preferences saved. || User: MyDomain\MyUsername 504 14:17:59.732 [5764] (w3wp) <4092> EV-L {EVS} End PreferenceConfigurator::Save() || User: MyDomain\MyUsername 505 14:17:59.732 [5764] (w3wp) <4092> EV-L {EVS} End ContentManagementService::SaveUserPreferences() || User: MyDomain\MyUsername 506 14:17:59.732 [5764] (w3wp) <4092> EV-L {EVS} End ClientDataService=>SetStartupLocationPreference() After SetUserPreference() || User: MyDomain\MyUsername 509 14:17:59.873 [5764] (w3wp) <5896> EV-H {WebAppCulture.SetCurrentThreadCulture} Checking language code it-it 510 14:17:59.873 [5764] (w3wp) <5896> EV-H {WebAppCulture.IsLanguageSupported} Language code it-it is not supported 511 14:17:59.873 [5764] (w3wp) <4092> EV-L {EVS} Auth Type Token 'Negotiate' found. User is windows impersonated user. || User: MyDomain\MyUsername 512 14:17:59.873 [5764] (w3wp) <5896> EV-H {WebAppCulture.SetCurrentThreadCulture} Checking language code it 513 14:17:59.873 [5764] (w3wp) <4092> EV-L {EVS} Done with authentication || User: MyDomain\MyUsername 514 14:17:59.873 [5764] (w3wp) <5896> EV-H {WebAppCulture.IsLanguageSupported} Language code it is supported 515 14:17:59.873 [5764] (w3wp) <5896> EV-L {WebAppCulture.SetCurrentThreadCulture} Culture set for it 516 14:17:59.873 [5764] (w3wp) <5896> EV:L {CQueue::CQueue} (Entry) 517 14:17:59.873 [5764] (w3wp) <4092> EV-L {EVS} Start ContentView Page Load || User: MyDomain\MyUsername 518 14:17:59.873 [5764] (w3wp) <5896> EV:L {CQueue::CQueue} (Exit) 519 14:17:59.888 [5764] (w3wp) <4092> EV-L {EVS} Start ReadingPresenter=>GetItemDetailHtml() || User: MyDomain\MyUsername 520 14:17:59.888 [5764] (w3wp) <5896> EV:L {CAutoStorageOnline::GetOnlineAttachmentFileSize2} (Entry) VaultID [1520CBE2F4F0289438B76222DAECC9B8D1110000archiving] 521 14:17:59.888 [5764] (w3wp) <4092> EV-L {EVS} Calling WCF to fetch item detail from EV server || User: MyDomain\MyUsername 522 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageProxyBase::GetStorageComputer} (Entry) 523 14:17:59.888 [5764] (w3wp) <4092> EV-L {EVS} Begin ContentManagementService::GetItemDetail() || User: MyDomain\MyUsername 524 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageOnlineOpnsInstanceHelper::GetCachedComputerInfo} (Entry) 525 14:17:59.888 [5764] (w3wp) <4092> EV-L {EVS} Begin SearchOrchestrator::GetItemDetail() vaultid : 1520CBE2F4F0289438B76222DAECC9B8D1110000archiving, Sequence No: 1000, AttachmentID: . || User: MyDomain\MyUsername 526 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageOnlineOpnsInstanceHelper::GetCachedComputerInfo:#147} Input ComputerNameOrEntryId: [1520CBE2F4F0289438B76222DAECC9B8D1110000archiving] - Found ComputerName: [archiving.MyDomain.it], SOO AdditionalInstanceCount: [4] 527 14:17:59.888 [5764] (w3wp) <4092> EV-L {EVS} SearchOrchestrator::GetItemDetail() Before Calling storage service || User: MyDomain\MyUsername 528 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageOnlineOpnsInstanceHelper::GetCachedComputerInfo} (Exit) Status: [Success] 529 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageProxyBase::GetStorageComputer} (Exit) Status: [Success] 530 14:17:59.888 [5764] (w3wp) <5896> EV:L {GetStorageObject:#46} Calling VaultCoCreateInstanceEx 531 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageOnlineOpnsInstanceHelper::GetCachedComputerInfo} (Entry) 532 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageOnlineOpnsInstanceHelper::GetCachedComputerInfo:#147} Input ComputerNameOrEntryId: [archiving.MyDomain.it] - Found ComputerName: [archiving.MyDomain.it], SOO AdditionalInstanceCount: [4] 533 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageOnlineOpnsInstanceHelper::GetCachedComputerInfo} (Exit) Status: [Success] 534 14:17:59.888 [5764] (w3wp) <5896> EV:L {CStorageOnlineOpnsInstanceHelper::GetStorageOnlineOpnsInstanceCLSID:#188} CLSID_StorageOnline Instance: [EVInstance03] 535 14:17:59.935 [5764] (w3wp) <5896> EV:L {VaultCoCreateInstanceEx} CLSID [{6642C136-4CBB-48D5-88F1-70CD703FD82D}] Server Name [archiving.MyDomain.it] Used Server Name [archiving.MyDomain.it] Num of attempts [1] Total elapsed [0.052s] Result [Success (0)] 536 14:17:59.935 [5764] (w3wp) <5896> EV:L {GetStorageObject:#53} Checking MULTI_QI.hr 537 14:17:59.935 [5764] (w3wp) <5896> EV:M {GetStorageObject:#59} Setting DCOM security 538 14:17:59.935 [5764] (w3wp) <5896> EV:L {CClientAuthenticate::GenAuthString:#361} Generating auth string... 539 14:17:59.935 [5764] (w3wp) <5896> EV:M ClientAuthHelperImpl::GenAuthString Authentication Type: Currently impersonated user Client:(null) ==> AuthToken:RMNETEV01.MyDomain.lan h5W1***** 540 14:18:00.169 [5764] (w3wp) <5896> EV:L CAuthHelper::Reset Cancel registration? True CancelId: 10854320 541 14:18:00.169 [5764] (w3wp) <5896> EV:L {CAutoStorageOnline::GetOnlineAttachmentFileSize2} (Exit) Status: [Success] 542 14:18:00.169 [5764] (w3wp) <5896> EV:L {CAutoStorageOnline::~CAutoStorageOnline} (Entry) 543 14:18:00.169 [5764] (w3wp) <5896> EV:L {CQueue::Delete} (Entry) 544 14:18:00.169 [5764] (w3wp) <5896> EV:H {CQueue::Delete}|Deleting queue: 545 14:18:00.169 [5764] (w3wp) <5896> EV:L {CQueue::Delete} (Exit) Status: [Success] 546 14:18:00.169 [5764] (w3wp) <5896> EV:L {CAutoStorageOnline::~CAutoStorageOnline} (Exit) Status: [Success] 547 14:18:00.169 [5764] (w3wp) <5896> EV:L {CQueue::~CQueue} (Entry) 548 14:18:00.169 [5764] (w3wp) <5896> EV:L {CQueue::~CQueue} (Exit) 549 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} SearchOrchestrator::GetItemDetail() After Calling storage service || User: MyDomain\MyUsername 550 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} End SearchOrchestrator::GetItemDetail() || User: MyDomain\MyUsername 551 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} End ContentManagementService::GetItemDetail() || User: MyDomain\MyUsername 552 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} Success: reading pane details fetched from EV server || User: MyDomain\MyUsername 553 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} Get plugin information for the item || User: MyDomain\MyUsername 554 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} ReadingPaneDetails.GetReadingPaneItem : Start Getting Reading Pane Details. || User: MyDomain\MyUsername 555 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} ReadingPaneDetails.GetReadingPaneItem : Item Metadata details are: ItemType = IPM.Note, Vault.MsgType = EXCH, FolderType = Inbox, ArchiveType = || User: MyDomain\MyUsername 556 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} ReadingPaneDetails.GetReadingPaneItem : End Getting Reading Pane Details. || User: MyDomain\MyUsername 557 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} Success: Plugin information fetched getting plugin || User: MyDomain\MyUsername 558 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} Content string Length:6773 || User: MyDomain\MyUsername 559 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} end ReadingPresenter=>GetItemDetailHtml() || User: MyDomain\MyUsername 560 14:18:00.169 [5764] (w3wp) <4092> EV-L {EVS} End ContentView Page Load || User: MyDomain\MyUsername 561 14:18:02.763 [2228] (EVIndexAdminService) <2296> EV-M {VelocityProcessHealthMonitor.CheckProcessPriority} VelocityProcessPriorityMonitor is performing it's periodic check of process priorities 562 14:18:06.029 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskQueue} TraceTimer [59999ms] BlockingDequeue: Semaphore.Wait 563 14:18:06.029 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskQueue} BlockingDequeue: Timed out waiting for a task. 564 14:18:06.029 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskThread} TraceTimer [59999ms] ThreadMain: taskQueue.Dequeue 565 14:18:06.029 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskProcessor} IdleTimeoutReached: At minimum threads, so telling thread to keep running. ThreadCount=3 566 14:18:06.029 [428] (EVIndexQueryServer) <5216> EV-L {SearchTaskThread} ThreadMain: No tasks available, but told to stick around, so will go back to waiting for task.