CID : cbc7409e-dfdb-202c-29fd-9b2ca96b0534 B01/15/2018 15:53:48.34 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Logging Correlation Data xmnv Medium Name=Request (POST:http://oits.olaf.cec.eu.int:80/Forms/_layouts/15/Postback.FormServer.aspx) cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.34 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Authentication Authorization agb9s Medium Non-OAuth request. IsAuthenticated=True, UserIdentityName=0#.w|net1\miklaad, ClaimsCount=116 cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.36 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Logging Correlation Data xmnv Medium Site=/ cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.41 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Performance ftq1 High [Forced due to logging gap, cached @ 01/15/2018 15:53:48.38, Original Level: Verbose] SearchFromGC name = {0}. start ... cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.41 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Performance ftq4 High [Forced due to logging gap, Original Level: Verbose] GetAccountNameFromSid "{0}" start ... cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.41 w3wp.exe (0x5E80) 0x3854 Secure Store Service Secure Store elo9 Medium Entering SecureStoreProviderFactory.GetDefaultSecureStoreProviderName cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.41 w3wp.exe (0x5E80) 0x3854 Secure Store Service Secure Store elp1 Medium Leaving SecureStoreProviderFactory.GetDefaultSecureStoreProviderName cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.41 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Topology e5mc Medium WcfSendRequest: RemoteAddress: 'https://s-olaf-sp13prd:32844/39d6bb328c614034821ecece2a17f87a/SecureStoreService.svc/https' Channel: 'Microsoft.Office.SecureStoreService.Server.ISecureStoreServiceApplication' Action: 'http://schemas.microsoft.com/sharepoint/2009/06/securestoreservice/ISecureStoreServiceApplication/GetUserApplication' MessageId: 'urn:uuid:57a33b27-9aa7-4dee-90eb-9d824bdf34a2' cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.41 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Monitoring nasq Medium Entering monitored scope (ExecuteWcfServerOperation). Parent No f98e9df7-f222-49f4-9ad2-30ee59856ad2 01/15/2018 15:53:48.42 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Topology e5mb Medium WcfReceiveRequest: LocalAddress: 'https://s-olaf-sp13prd.net1.cec.eu.int:32844/39d6bb328c614034821ecece2a17f87a/SecureStoreService.svc/https' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://schemas.microsoft.com/sharepoint/2009/06/securestoreservice/ISecureStoreServiceApplication/GetUserApplication' MessageId: 'urn:uuid:57a33b27-9aa7-4dee-90eb-9d824bdf34a2' cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.42 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Micro Trace uls4 Medium Micro Trace Tags: 0 nasq,0 e5mb cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.42 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Monitoring b4ly Medium Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=6.685 cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.42 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Topology e5mc Medium WcfSendRequest: RemoteAddress: 'https://s-olaf-sp13prd:32844/39d6bb328c614034821ecece2a17f87a/SecureStoreService.svc/https' Channel: 'Microsoft.Office.SecureStoreService.Server.ISecureStoreServiceApplication' Action: 'http://schemas.microsoft.com/sharepoint/2009/06/securestoreservice/ISecureStoreServiceApplication/GetCredentials' MessageId: 'urn:uuid:4bdcfe78-0c3f-421e-b407-b031bbaf488b' cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.42 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Monitoring nasq Medium Entering monitored scope (ExecuteWcfServerOperation). Parent No f98e9df7-f222-49f4-9ad2-30ee59856ad2 01/15/2018 15:53:48.42 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Topology e5mb Medium WcfReceiveRequest: LocalAddress: 'https://s-olaf-sp13prd.net1.cec.eu.int:32844/39d6bb328c614034821ecece2a17f87a/SecureStoreService.svc/https' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://schemas.microsoft.com/sharepoint/2009/06/securestoreservice/ISecureStoreServiceApplication/GetCredentials' MessageId: 'urn:uuid:4bdcfe78-0c3f-421e-b407-b031bbaf488b' cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.42 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Micro Trace uls4 Medium Micro Trace Tags: 0 nasq,0 e5mb cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.42 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Monitoring b4ly Medium Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=2.292 cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.42 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1b8 Medium Web Request: Begins url=http://oits.olaf.cec.eu.int/_vti_bin/UserProfileService.asmx action=http://microsoft.com/webservices/SharePointPortalServer/UserProfileService/GetUserProfileByName cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1be Medium Web Request: Preparing SOAP message cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1b9 Medium Web Request: Preparing WebRequest cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections amdlr Medium Internal web service routing is NOT enabled. cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1b7 Medium Web Request: Writing request stream cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1ba Medium Web Request: Getting response cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x55C4 SharePoint Foundation Monitoring nasq Medium Entering monitored scope (Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName")). Parent No 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x55C4 SharePoint Foundation Logging Correlation Data xmnv Medium Name=Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName") cbc7409e-bfe1-202c-29fd-9c17ea8a489a 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x55C4 SharePoint Foundation Authentication Authorization agb9s Medium Non-OAuth request. IsAuthenticated=False, UserIdentityName=, ClaimsCount=0 cbc7409e-bfe1-202c-29fd-9c17ea8a489a 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x55C4 SharePoint Foundation Micro Trace uls4 Medium Micro Trace Tags: 0 nasq,0 agb9s cbc7409e-bfe1-202c-29fd-9c17ea8a489a 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x55C4 SharePoint Foundation Monitoring b4ly Medium Leaving Monitored Scope (Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName")). Execution Time=1,5797 cbc7409e-bfe1-202c-29fd-9c17ea8a489a 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x1B20 SharePoint Foundation Monitoring nasq Medium Entering monitored scope (Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName")). Parent No 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x1B20 SharePoint Foundation Logging Correlation Data xmnv Medium Name=Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName") cbc7409e-bfe1-202c-29fd-90541b108774 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x1B20 SharePoint Foundation Micro Trace uls4 Medium Micro Trace Tags: 0 nasq cbc7409e-bfe1-202c-29fd-90541b108774 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x1B20 SharePoint Foundation Monitoring b4ly Medium Leaving Monitored Scope (Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName")). Execution Time=0,7337 cbc7409e-bfe1-202c-29fd-90541b108774 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Foundation Monitoring nasq Medium Entering monitored scope (Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName")). Parent No 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Foundation Logging Correlation Data xmnv Medium Name=Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName") cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Foundation Authentication Authorization agb9s Medium Non-OAuth request. IsAuthenticated=True, UserIdentityName=0#.w|net1\olaf-sp_farm, ClaimsCount=62 cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Portal Server User Profiles fvg3 Medium SoapAction: "http://microsoft.com/webservices/SharePointPortalServer/UserProfileService/GetUserProfileByName" cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Portal Server User Profiles fvg4 Medium net1\angelaw cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Foundation Logging Correlation Data xmnv Medium Site=/ cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Portal Server User Profiles ajk39 Medium UserProfileDBCache_WCFLogging::Begin ProfileDBCacheServiceClient.GetUserData.ExecuteOnChannel cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Portal Server User Profiles ajk35 Medium MossClientBase_WCFLogging::Begin MossClientBase.ExecuteOnChannel cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Portal Server User Profiles ajk36 Medium MossClientBase_WCFLogging:: MossClientBase.ExecuteOnChannel - Executing codeblock on channel cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.44 w3wp.exe (0x5E80) 0x6C04 SharePoint Foundation Topology e5mc Medium WcfSendRequest: RemoteAddress: 'http://s-olaf-sp13prd:32843/0ef13ad80c754e4f910d598c8ce70b88/ProfileDBCacheService.svc' Channel: 'Microsoft.Office.Server.UserProfiles.IProfileDBCacheService' Action: 'http://Microsoft.Office.Server.UserProfiles/GetUserData' MessageId: 'urn:uuid:77aeeab4-6fd0-4002-9fb7-c70b8068de15' cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Monitoring nasq Medium Entering monitored scope (ExecuteWcfServerOperation). Parent No f98e9df7-f222-49f4-9ad2-30ee59856ad2 01/15/2018 15:53:48.45 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Topology e5mb Medium WcfReceiveRequest: LocalAddress: 'http://s-olaf-sp13prd.net1.cec.eu.int:32843/0ef13ad80c754e4f910d598c8ce70b88/ProfileDBCacheService.svc' Channel: 'System.ServiceModel.Channels.ServiceChannel' Action: 'http://Microsoft.Office.Server.UserProfiles/GetUserData' MessageId: 'urn:uuid:77aeeab4-6fd0-4002-9fb7-c70b8068de15' cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Micro Trace uls4 Medium Micro Trace Tags: 0 nasq,0 e5mb cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x3340) 0x4754 SharePoint Foundation Monitoring b4ly Medium Leaving Monitored Scope (ExecuteWcfServerOperation). Execution Time=2.6272 cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x6C04 SharePoint Portal Server User Profiles ajk37 Medium MossClientBase_WCFLogging:: MossClientBase.ExecuteOnChannel - Executed codeblock on channel cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x6C04 SharePoint Portal Server User Profiles ajk4a Medium UserProfileDBCache_WCFLogging::End ProfileDBCacheServiceClient.GetUserData.ExecuteOnChannel cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x6C04 SharePoint Foundation Micro Trace uls4 Medium Micro Trace Tags: 0 nasq,9 agb9s,0 fvg3,0 fvg4,5 ajk39,0 ajk35,0 ajk36,0 e5mc,8 ajk37,0 ajk4a cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x6C04 SharePoint Foundation Monitoring b4ly Medium Leaving Monitored Scope (Request (POST:http://oits.olaf.cec.eu.int:80/_vti_bin/UserProfileService.asmx:GetUserProfileByName")). Execution Time=26.0561 cbc7409e-bfe1-202c-29fd-9f116b35f31e 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections amdl5 Exception System.Net.WebException: The remote server returned an error: (500) Internal Server Error. at System.Net.HttpWebRequest.GetResponse() at Microsoft.Office.InfoPath.Server.SolutionLifetime.WebServiceHelper.GetResponseHelper(WebRequest request, DataAdapterCredentials credentials, Stopwatch timer, ExecWebRequestExceptionState state, String adapterName, Boolean isQuery) at Microsoft.Office.InfoPath.Server.SolutionLifetime.WebServiceHelper.ExecWebRequestSync(XPathNavigator inputSubDOM, Boolean[] inputUseDataset, XPathNavigator resultsSubDOM, Boolean resultUseDataset, XPathNavigator errorsSubDOM, Uri serviceUrl, Uri soapAction, Int64 timeOutMillisec, DataAdapter adapter, Document document, DataAdapterCredentials credentials, Boolean useDcl, Boolean useProxy, Boolean useSelf) StackTra... cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45* w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections amdl5 Exception ...ce: at Microsoft.Office.Server.Native.dll: (sig=9afccfd8-248d-4fb9-a01a-c8bacd6f7473|2|microsoft.office.server.native.pdb, offset=135DA) at Microsoft.Office.Server.Native.dll: (offset=21F8D) cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x3854 SharePoint Server Unified Logging Service c91s Monitorable Watson bucket parameters: SharePoint Server 2013, ULSException14, 41b7c39f "infopath forms services", 0f0011d9 "15.0.4569.0", 18b0be27 "system", 04070845 "4.7.2117.0", 59cf51b3 "sat sep 30 10:11:31 2017", 00000a01 "00000a01", 00000283 "00000283", 4380fbf4 "webexception", 003032df "amdl5" cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1bf Medium Web Request: WebException Caught cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1bc Medium Web Request: Copying response to DOMs cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1bc Medium Web Request: Copying response to DOMs cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1bb Medium Web Request: Ends url=http://oits.olaf.cec.eu.int/_vti_bin/UserProfileService.asmx action=http://microsoft.com/webservices/SharePointPortalServer/UserProfileService/GetUserProfileByName cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1v0 Warning The following query failed: GetUserProfileByName (User: 0#.w|net1\miklaad, Form Name: FL_AccessRights_111021, IP: , Connection Target: http://oits.olaf.cec.eu.int/Forms/DCL_OITS_UDCX/GetUserProfileByName.udcx, Request: http://oits.olaf.cec.eu.int/Forms/_layouts/15/FormServer.aspx?XsnLocation=/forms/fl_accessrights_111021/forms/template.xsn&DefaultItemOpen=1, Form ID: urn:schemas-microsoft-com:office:infopath:FL-AccessRights-111021:-myXSD-2010-05-30T16-59-00 Type: DataAdapterException, Exception Message: The remote server returned an error: (500) Internal Server Error. A user with the account name net1\angelaw could not be found. ---> An error was encountered while retrieving the user profile. UserCannotBeFoundAn error was encountered while retrieving the user profile. The remote server r... cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.45* w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime - Data Connections m1v0 Warning ...eturned an error: (500) Internal Server Error.) cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.52 w3wp.exe (0x5E80) 0x3854 SharePoint Server Database ahjqp High [Forced due to logging gap, cached @ 01/15/2018 15:53:48.50, Original Level: Verbose] SQL connection time: 0.0594 for Data Source=SQL4SHAREPOINT;Initial Catalog=SP2013_PROD_StateService;Integrated Security=True;Enlist=False;Pooling=True;Min Pool Size=0;Max Pool Size=100;Connect Timeout=15 cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.52 w3wp.exe (0x5E80) 0x3854 InfoPath Forms Services Runtime m1sa High [Forced due to logging gap, Original Level: Verbose] GlobalStorage.Enter: New context - {0} Total contexts - {1} cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.53 w3wp.exe (0x5E80) 0x3854 SharePoint Server State Service 8kfs Medium The StateManager is disposing and calling ReleaseLockedStates() (Count=0) cbc7409e-dfdb-202c-29fd-9b2ca96b0534 01/15/2018 15:53:48.53 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Micro Trace uls4 Medium Micro Trace Tags: 0 nasq,6 agb9s,61 elo9,0 elp1,0 e5mc,13 e5mc,8 m1b8,0 m1be,0 m1b9,0 amdlr,0 m1b7,0 m1ba,35 m1bf,0 m1bc,0 m1bc,0 m1bb,62 8kfs cbc7409e-dfdb-202c-29fd-9b2ca96b0534 B01/15/2018 15:53:48.53 w3wp.exe (0x5E80) 0x3854 SharePoint Foundation Monitoring b4ly Medium Leaving Monitored Scope (Request (POST:http://oits.olaf.cec.eu.int:80/Forms/_layouts/15/Postback.FormServer.aspx)). Execution Time=188,2893 cbc7409e-dfdb-202c-29fd-9b2ca96b0534