6 Replies Latest reply on Mar 4, 2009 6:06 PM by Nick Belaevski

    Suggestbox performance

    Travis De Silva Newbie

      Hi,

      I activate the Suggestbox using the component.callSuggestion Javascript function.

      It takes around 3-4 seconds to display the Suggestbox. My database query results return in around 80ms. When I view the server console debug output, I notice that it takes about 3 secs to come into the method called by suggestionAction.

      I added the frequency attribute as well and added 0, 0.2 etc values but did not see any noticeable difference.

      Is this the standard response time for a SuggestBox? I am hoping that we should be able to display it in less than a second. (note the app runs in an intranet/LAN environment)

      Travis


        • 1. Re: Suggestbox performance
          Nick Belaevski Master

          Hello Travis,

          Not that's not a standard time. Can you please post PhaseTracker log?

          • 2. Re: Suggestbox performance
            Travis De Silva Newbie

            Hi Nick,

            Thank you for your prompt reply.

            What you mean by the PhaseTracker is monitoring the requests via the a4j log component right?

            Wow.. that is really a cool component.. first time I used it and it can lead to great understanding of what is happening under the hood.

            Anyway there is something really strange happening. As the log output below indicates, it seems to be taking all the components on the page and submitting it.

            I am not sure why this happens since I have the suggestbox within a a4j region component.

            This is the code snippet of how I call it. Note that I have many suggestboxes on the single form and other forms as well and therefore I have created a common template for it.

            <a:region renderRegionOnly="true">
             <s:decorate id="projectManagerField" template="layout/edit.xhtml">
             <ui:define name="label">Project Manager Email</ui:define>
             <h:inputText id="projectManager" required="true" size="80" value="#{recommendationHome.projectManagerEmail}"/>
             <ui:include src="template/SuggestionBox.xhtml">
             <ui:param name="suggestCompleteFieldId" value="recommendation:projectManagerField:projectManager"/>
             <ui:param name="suggestFieldId" value="projectManager"/>
             </ui:include>
             </s:decorate>
             <a:log popup="false" level="ALL" style="width: 800px; height: 300px;"></a:log>
            </a:region>


            The common template (i.e. SuggestionBox.xhtml) code.

            <!DOCTYPE composition PUBLIC "-//W3C//DTD XHTML 1.0 Transitional//EN"
             "http://www.w3.org/TR/xhtml1/DTD/xhtml1-transitional.dtd">
            <ui:composition xmlns="http://www.w3.org/1999/xhtml"
             xmlns:s="http://jboss.com/products/seam/taglib"
             xmlns:ui="http://java.sun.com/jsf/facelets"
             xmlns:f="http://java.sun.com/jsf/core"
             xmlns:h="http://java.sun.com/jsf/html"
             xmlns:a="http://richfaces.org/a4j"
             xmlns:rich="http://richfaces.org/rich">
            
             <script type="text/javascript">
             function openSuggest(fieldId) {
             document.getElementById(fieldId).component.callSuggestion(true);
             }
             </script>
            
             <a:region renderRegionOnly="true">
            
             <h:graphicImage value="/img/suggest.gif" id="#{suggestFieldId}_SuggestIcon"
             onclick="openSuggest('#{suggestCompleteFieldId}_Suggestbox')"
             style="cursor:pointer;" alt="suggestion list">
             </h:graphicImage>
            
             <rich:suggestionbox height="300" width="700" usingSuggestObjects="false"
             suggestionAction="#{suggestBoxQuery.autoCompleteEmailWithInactive}"
             var="_recordSet" for="#{suggestFieldId}"
             minChars="70" ajaxSingle="true" bypassUpdates="true" immediate="true" selfRendered="true"
             process="#{suggestCompleteFieldId}"
             rowClasses="suggest-table-cell" frequency="0.2" nothingLabel="No Records Found"
             id="#{suggestFieldId}_Suggestbox">
             <f:facet name="header">
             <rich:columnGroup>
             <rich:column colspan="4" style="border-right:0px;">
             <h:outputText value="Suggestion Box" />
             </rich:column>
             <rich:column breakBefore="true" styleClass="rich-table-subheadercell">
             <h:outputText value="Email"/>
             </rich:column>
             <rich:column styleClass="rich-table-subheadercell">
             <h:outputText value="Name"/>
             </rich:column>
             <rich:column styleClass="rich-table-subheadercell">
             <h:outputText value="Position" />
             </rich:column>
             <rich:column styleClass="rich-table-subheadercell">
             <h:outputText value="Status" />
             </rich:column>
             </rich:columnGroup>
             </f:facet>
             <h:column>
             <h:outputText value="#{_recordSet.email}"/>
             </h:column>
             <h:column>
             <h:outputText value="#{_recordSet.employeeName}"/>
             </h:column>
             <h:column>
             <h:outputText value="#{_recordSet.position}"/>
             </h:column>
             <h:column>
             <h:outputText value="#{_recordSet.active==1 ? 'Active' : 'Inactive'}"/>
             </h:column>
             </rich:suggestionbox>
            
             </a:region>
            
            </ui:composition>



            Here goes the log output. It is really really large!!!

            debug[9:32:12,828]: set timeout for request suggestion
            debug[9:32:13,029]: Observer event occurs
            debug[9:32:13,029]: Call data for update choices
            debug[9:32:13,030]: Have Event [object Object] with properties: target: [object HTMLInputElement], srcElement: undefined, type: keydown
            debug[9:32:13,031]: Query preparation for form 'recommendation' requested
            debug[9:32:13,032]: Append hidden control recommendation with value [recommendation] and value attribute [recommendation]
            debug[9:32:13,033]: Append text control recommendation:projectNumberField:projectNumber with value [PX1] and value attribute [PX1]
            debug[9:32:13,033]: Append text control recommendation:projectNameField:projectName with value [Project PX1] and value attribute [Project PX1]
            debug[9:32:13,034]: Append text control recommendation:programNumberField:programNumber with value [X1] and value attribute [X1]
            debug[9:32:13,034]: Append text control recommendation:programNameField:programName with value [Program X1] and value attribute [Program X1]
            debug[9:32:13,035]: Append text control recommendation:pirReportDateField:pirReportDateInputDate with value [27/02/2009] and value attribute [27/02/2009]
            debug[9:32:13,036]: Append hidden control recommendation:pirReportDateField:pirReportDateInputCurrentDate with value [02/2009] and value attribute [02/2009]
            debug[9:32:13,036]: Append select-one control recommendation:businessUnitField:businessUnit with value [2] and value attribute [null]
            debug[9:32:13,037]: Append text control recommendation:applicationNameField:applicationName with value [Project PX1 Application Name] and value attribute [Project PX1 Application Name]
            debug[9:32:13,038]: Append text control recommendation:pirReportOdmUrlField:pirReportOdmUrl with value [http://test-001.xyz.com.au/livelink/llisapi.dll/E6923_OBD_CRM_PIR_Report.doc?func=doc.Fetch&nodeId=15953380&docTitle=E6923+OBD+CRM+PIR+Report&viewType=1] and value attribute [http://test-001.xyz.com.au/livelink/llisapi.dll/E6923_OBD_CRM_PIR_Report.doc?func=doc.Fetch&nodeId=15953380&docTitle=E6923+OBD+CRM+PIR+Report&viewType=1]
            debug[9:32:13,038]: Append text control recommendation:projectManagerField:projectManager with value [Travis.De.Silva@xyz.com.au] and value attribute [Travis.De.Silva@xyz.com.au]
            debug[9:32:13,039]: Append hidden control recommendation:projectManagerField:projectManager_Suggestbox_selection with value [] and value attribute [null]
            debug[9:32:13,039]: Append text control recommendation:sponsorField:sponsor with value [Travis.De.Silva@xyz.com.au] and value attribute [Travis.De.Silva@xyz.com.au]
            debug[9:32:13,040]: Append hidden control recommendation:sponsorField:sponsor_Suggestbox_selection with value [] and value attribute [null]
            debug[9:32:13,041]: Append text control recommendation:businessOwnerField:businessOwner with value [Travis.De.Silva@xyz.com.au] and value attribute [Travis.De.Silva@xyz.com.au]
            debug[9:32:13,041]: Append hidden control recommendation:businessOwnerField:businessOwner_Suggestbox_selection with value [] and value attribute [null]
            debug[9:32:13,042]: Append text control recommendation:itDomainOwnerField:itDomainOwner with value [Travis.De.Silva@xyz.com.au] and value attribute [Travis.De.Silva@xyz.com.au]
            debug[9:32:13,043]: Append hidden control recommendation:itDomainOwnerField:itDomainOwner_Suggestbox_selection with value [] and value attribute [null]
            debug[9:32:13,043]: Append select-one control recommendation:enterRecommendationsField:enterRecommendations with value [false] and value attribute [null]
            debug[9:32:13,044]: Append hidden control javax.faces.ViewState with value [j_id4] and value attribute [j_id4]
            debug[9:32:13,044]: parameter ajaxSingle with value recommendation:projectManagerField:projectManager_Suggestbox
            debug[9:32:13,045]: parameter recommendation:projectManagerField:projectManager_Suggestbox with value recommendation:projectManagerField:projectManager_Suggestbox
            debug[9:32:13,045]: parameter inputvalue with value Travis.De.Silva@xyz.com.au
            debug[9:32:13,045]: Look up queue with name 'recommendation:projectManagerField:projectManager_Suggestbox'
            debug[9:32:13,046]: Creating new transient queue 'recommendation:projectManagerField:projectManager_Suggestbox' with default settings
            debug[9:32:13,046]: Adding queue 'recommendation:projectManagerField:projectManager_Suggestbox' to queues registry
            debug[9:32:13,046]: Queue is empty now
            debug[9:32:13,047]: New request added to queue 'recommendation:projectManagerField:projectManager_Suggestbox'. Queue similarityGroupingId changed to recommendation:projectManagerField:projectManager_Suggestbox
            debug[9:32:13,047]: Queue will wait 0ms before submit
            debug[9:32:13,048]: Queue 'recommendation:projectManagerField:projectManager_Suggestbox' will submit request NOW
            debug[9:32:13,049]: NEW AJAX REQUEST !!! with form: recommendation
            debug[9:32:13,050]: Start XmlHttpRequest
            debug[9:32:13,051]: Reqest state : 1
            debug[9:32:13,052]: QueryString: AJAXREQUEST=recommendation%3AprojectManagerField%3Aj_id307&recommendation=recommendation&recommendation%3AprojectNumberField%3AprojectNumber=PX1&recommendation%3AprojectNameField%3AprojectName=Project%20PX1&recommendation%3AprogramNumberField%3AprogramNumber=X1&recommendation%3AprogramNameField%3AprogramName=Program%20X1&recommendation%3ApirReportDateField%3ApirReportDateInputDate=27%2F02%2F2009&recommendation%3ApirReportDateField%3ApirReportDateInputCurrentDate=02%2F2009&recommendation%3AbusinessUnitField%3AbusinessUnit=2&recommendation%3AapplicationNameField%3AapplicationName=Project%20PX1%20Application%20Name&recommendation%3ApirReportOdmUrlField%3ApirReportOdmUrl=http%3A%2F%2Ftest-001.xyz.com.au%2Flivelink%2Fllisapi.dll%2FE6923_OBD_CRM_PIR_Report.doc%3Ffunc%3Ddoc.Fetch%26nodeId%3D15953380%26docTitle%3DE6923%2BOBD%2BCRM%2BPIR%2BReport%26viewType%3D1&recommendation%3AprojectManagerField%3AprojectManager=Travis.De.Silva%40xyz.com.au&recommendation%3AprojectManagerField%3AprojectManager_Suggestbox_selection=&recommendation%3AsponsorField%3Asponsor=Travis.De.Silva%40xyz.com.au&recommendation%3AsponsorField%3Asponsor_Suggestbox_selection=&recommendation%3AbusinessOwnerField%3AbusinessOwner=Travis.De.Silva%40xyz.com.au&recommendation%3AbusinessOwnerField%3AbusinessOwner_Suggestbox_selection=&recommendation%3AitDomainOwnerField%3AitDomainOwner=Travis.De.Silva%40xyz.com.au&recommendation%3AitDomainOwnerField%3AitDomainOwner_Suggestbox_selection=&recommendation%3AenterRecommendationsField%3AenterRecommendations=false&javax.faces.ViewState=j_id4&ajaxSingle=recommendation%3AprojectManagerField%3AprojectManager_Suggestbox&recommendation%3AprojectManagerField%3AprojectManager_Suggestbox=recommendation%3AprojectManagerField%3AprojectManager_Suggestbox&inputvalue=Travis.De.Silva%40xyz.com.au&AJAX%3AEVENTS_COUNT=1&
            debug[9:32:13,054]: Reqest state : 1
            debug[9:32:15,032]: Reqest state : 2
            debug[9:32:15,035]: Reqest state : 3
            debug[9:32:15,035]: Reqest state : 4
            debug[9:32:15,036]: Reqest end with state 4
            debug[9:32:15,036]: Response with content-type: text/xml;charset=UTF-8
            debug[9:32:15,036]: Full response content: <?xml version="1.0"?> Suggestion BoxEmailNamePositionStatusTravis.De.Silva@xyz.com.auTravis DE SILVASolution DeveloperActiveNo Records Found
            debug[9:32:15,038]: Header Ajax-Expired not found, search in
            debug[9:32:15,038]: search for elements by name 'meta' in element #document
            debug[9:32:15,039]: Find
            debug[9:32:15,039]: Find
            debug[9:32:15,039]: Header Ajax-Update-Ids not found, search in
            debug[9:32:15,040]: search for elements by name 'meta' in element #document
            debug[9:32:15,040]: Find
            debug[9:32:15,040]: Update page by list of rendered areas from response recommendation:projectManagerField:projectManager_Suggestbox:suggest
            debug[9:32:15,041]: search for elements by name 'script' in element #document
            debug[9:32:15,042]: search for elements by name 'link' in element #document
            debug[9:32:15,043]: in response with src=/pirlessons/a4j/s/3_3_0.GAstylesheet/theme.xcss/DATB/eAGbo7-tNnT5DGkAEXoDrg__
            debug[9:32:15,043]: Such element exist in document
            debug[9:32:15,043]: in response with src=/pirlessons/stylesheet/theme.css
            debug[9:32:15,044]: Such element exist in document
            debug[9:32:15,044]: call getElementById for id= org.ajax4jsf.queue_script
            debug[9:32:15,044]: Update page part from call parameter for ID recommendation:projectManagerField:projectManager_Suggestbox:suggest
            debug[9:32:15,045]: call getElementById for id= recommendation:projectManagerField:projectManager_Suggestbox:suggest
            debug[9:32:15,046]: Replace content of node by replaceChild()
            debug[9:32:15,047]: search for elements by name 'script' in element table
            debug[9:32:15,047]: Scripts in updated part count : 0
            debug[9:32:15,047]: call getElementById for id= org.ajax4jsf.oncomplete
            debug[9:32:15,048]: Call local oncomplete function after processing updates
            debug[9:32:15,048]: After request: queue 'recommendation:projectManagerField:projectManager_Suggestbox'
            debug[9:32:15,048]: There are 0 requests more in this queue
            debug[9:32:15,049]: Queue is empty now
            debug[9:32:15,049]: Update part of page for Id: recommendation:projectManagerField:projectManager_Suggestbox:suggest successful
            debug[9:32:15,049]: call getElementById for id= ajax-view-state
            debug[9:32:15,050]: Hidden JSF state fields: [object HTMLSpanElement]
            debug[9:32:15,050]: Namespace for hidden view-state input fields is undefined
            debug[9:32:15,050]: search for elements by name 'input' in element span
            debug[9:32:15,051]: Replace value for inputs: 26 by new values: 1
            debug[9:32:15,051]: Input in response: javax.faces.ViewState
            debug[9:32:15,052]: Found same input on page with type: hidden
            debug[9:32:15,053]: Found same input on page with type: hidden
            debug[9:32:15,053]: search for elements by name 'INPUT' in element span
            debug[9:32:15,054]: Replace value for inputs: 26 by new values: 0
            debug[9:32:15,054]: call getElementById for id= _A4J.AJAX.focus
            debug[9:32:15,054]: No focus information in response
            debug[9:32:15,074]: call getElementById for id= _ajax:data
            debug[9:32:15,075]: AJAX response complete - updateChoices
            debug[9:32:15,094]: render for index 0 and old index -1

            • 3. Re: Suggestbox performance
              Travis De Silva Newbie

              On further inspection of the above log output, looks like the time spent between request state 1 to 2 is nearly 2 secs. I believe request 2 corresponds to Apply Request values in JSF.

              Now for some reason, the request query string has added all the components in the form. I was under the impression that it should add only the component where I made the request for the suggestbox.

              I have used the process attribute and added the id of the component as well. So not sure why all those other request parameters are added.

              • 4. Re: Suggestbox performance
                Nick Belaevski Master

                a4j:log doesn't give enough information about timing of particular phase. 1 and 2 are the different readyState values of XMLHttpRequest object. Please add PhaseTracker: http://www.jsftutorials.net/faces-config/phaseTracker.html and post its log.

                All form fields are sent to the server, even if ajaxSingle is used; process and ajaxSingle attributes limit server-side processing and not the client-side.

                • 5. Re: Suggestbox performance
                  Travis De Silva Newbie

                  Thanks Nick. Following is the output log of the PhaseTracker.

                  Overall, from the first log output to the last one, it looks like it takes only 439ms. But the display on the screen takes over 3 secs.

                  Also I notice in the below log, there seems to be two sets of logs per life cycle. (e.g. there are two BEFORE RESTORE_VIEW 1 and so on.) Shouldn't it be only one since I am not activating any other request?


                  09:06:46,473 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE RESTORE_VIEW 1
                  09:06:46,473 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE RESTORE_VIEW 1
                  09:06:46,531 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER RESTORE_VIEW 1
                  09:06:46,533 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER RESTORE_VIEW 1
                  09:06:46,537 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE APPLY_REQUEST_VALUES 2
                  09:06:46,537 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE APPLY_REQUEST_VALUES 2
                  09:06:46,572 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER APPLY_REQUEST_VALUES 2
                  09:06:46,572 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER APPLY_REQUEST_VALUES 2
                  09:06:46,574 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE PROCESS_VALIDATIONS 3
                  09:06:46,575 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE PROCESS_VALIDATIONS 3
                  09:06:46,604 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER PROCESS_VALIDATIONS 3
                  09:06:46,604 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER PROCESS_VALIDATIONS 3
                  09:06:46,606 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE UPDATE_MODEL_VALUES 4
                  09:06:46,606 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE UPDATE_MODEL_VALUES 4
                  09:06:46,627 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER UPDATE_MODEL_VALUES 4
                  09:06:46,628 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER UPDATE_MODEL_VALUES 4
                  09:06:46,629 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE INVOKE_APPLICATION 5
                  09:06:46,638 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE INVOKE_APPLICATION 5
                  09:06:46,638 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER INVOKE_APPLICATION 5
                  09:06:46,639 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER INVOKE_APPLICATION 5
                  09:06:46,688 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE RENDER_RESPONSE 6
                  09:06:46,689 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker beforePhase
                  INFO: BEFORE RENDER_RESPONSE 6
                  09:06:46,728 INFO [STDOUT] Hibernate:
                  select
                  employee0_.employee_id as employee1_9_,
                  employee0_.location as location9_,
                  employee0_.position as position9_,
                  employee0_.manager as manager9_,
                  employee0_.extension as extension9_,
                  employee0_.node as node9_,
                  employee0_.active as active9_,
                  employee0_.email as email9_,
                  employee0_.business_unit as business8_9_,
                  employee0_.first_name as first9_9_,
                  employee0_.middle_initial as middle10_9_,
                  employee0_.last_name as last11_9_,
                  employee0_.phone as phone9_,
                  employee0_.team as team9_,
                  employee0_.department as department9_,
                  employee0_.division as division9_,
                  employee0_.cc_opex as cc16_9_,
                  employee0_.cc_payroll as cc17_9_,
                  employee0_.second_level_manager as second23_9_,
                  employee0_.company as company9_,
                  employee0_.mobile as mobile9_,
                  employee0_.pager as pager9_,
                  employee0_.assistant as assistant9_,
                  employee0_.fax as fax9_
                  from
                  od.employee employee0_
                  where
                  lower(employee0_.email) like concat(lower(?), '%') limit ?
                  09:06:46,912 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER RENDER_RESPONSE 6
                  09:06:46,912 ERROR [STDERR] 5/03/2009 09:06:46 org.exadel.jsf.PhaseTracker afterPhase
                  INFO: AFTER RENDER_RESPONSE 6

                  • 6. Re: Suggestbox performance
                    Nick Belaevski Master

                    That's strange. Here is what I get:

                    debug[1:04:46,477]: NEW AJAX REQUEST !!! with form: j_id3
                    debug[1:04:46,485]: Start XmlHttpRequest
                    debug[1:04:46,486]: Reqest state : 1
                    debug[1:04:46,524]: QueryString: AJAXREQUEST=_viewRoot&j_id3=j_id3&j_id3%3Atbl%3Aj_id15=&j_id3%3Atbl%3Aj_id22=&j_id3%3Atbl%3A0%3Aattribute=Name%200h&j_id3%3Atbl%3A0%3AreplySuggestions_selection=&j_id3%3Atbl%3A0%3Aj_id9=&j_id3%3Atbl%3A0%3Aj_id21=&j_id3%3Atbl%3A1%3Aattribute=Name%201&j_id3%3Atbl%3A1%3AreplySuggestions_selection=&j_id3%3Atbl%3A1%3Aj_id9=&j_id3%3Atbl%3A1%3Aj_id21=&j_id3%3Atbl%3A2%3Aattribute=Name%202&j_id3%3Atbl%3A2%3AreplySuggestions_selection=&j_id3%3Atbl%3A2%3Aj_id9=&j_id3%3Atbl%3A2%3Aj_id21=&j_id3%3Atbl%3A3%3Aattribute=Name%203&j_id3%3Atbl%3A3%3AreplySuggestions_selection=&j_id3%3Atbl%3A3%3Aj_id9=&j_id3%3Atbl%3A3%3Aj_id21=&j_id3%3Atbl%3A4%3Aattribute=Name%204&j_id3%3Atbl%3A4%3AreplySuggestions_selection=&j_id3%3Atbl%3A4%3Aj_id9=&j_id3%3Atbl%3A4%3Aj_id21=&j_id3%3Atbl%3A5%3Aattribute=Name%205&j_id3%3Atbl%3A5%3AreplySuggestions_selection=&j_id3%3Atbl%3A5%3Aj_id9=&j_id3%3Atbl%3A5%3Aj_id21=&j_id3%3Atbl%3A6%3Aattribute=Name%206&j_id3%3Atbl%3A6%3AreplySuggestions_selection=&j_id3%3Atbl%3A6%3Aj_id9=&j_id3%3Atbl%3A6%3Aj_id21=&j_id3%3Atbl%3A7%3Aattribute=Name%207&j_id3%3Atbl%3A7%3AreplySuggestions_selection=&j_id3%3Atbl%3A7%3Aj_id9=&j_id3%3Atbl%3A7%3Aj_id21=&j_id3%3Atbl%3A8%3Aattribute=Name%208&j_id3%3Atbl%3A8%3AreplySuggestions_selection=&j_id3%3Atbl%3A8%3Aj_id9=&j_id3%3Atbl%3A8%3Aj_id21=&j_id3%3Atbl%3A9%3Aattribute=Name%209&j_id3%3Atbl%3A9%3AreplySuggestions_selection=&j_id3%3Atbl%3A9%3Aj_id9=&j_id3%3Atbl%3A9%3Aj_id21=&j_id3%3Atbl%3A10%3Aattribute=Name%2010&j_id3%3Atbl%3A10%3AreplySuggestions_selection=&j_id3%3Atbl%3A10%3Aj_id9=&j_id3%3Atbl%3A10%3Aj_id21=&j_id3%3Atbl%3A11%3Aattribute=Name%2011&j_id3%3Atbl%3A11%3AreplySuggestions_selection=&j_id3%3Atbl%3A11%3Aj_id9=&j_id3%3Atbl%3A11%3Aj_id21=&j_id3%3Atbl%3A12%3Aattribute=Name%2012&j_id3%3Atbl%3A12%3AreplySuggestions_selection=&j_id3%3Atbl%3A12%3Aj_id9=&j_id3%3Atbl%3A12%3Aj_id21=&j_id3%3Atbl%3A13%3Aattribute=Name%2013&j_id3%3Atbl%3A13%3AreplySuggestions_selection=&j_id3%3Atbl%3A13%3Aj_id9=&j_id3%3Atbl%3A13%3Aj_id21=&j_id3%3Atbl%3A14%3Aattribute=Name%2014&j_id3%3Atbl%3A14%3AreplySuggestions_selection=&j_id3%3Atbl%3A14%3Aj_id9=&j_id3%3Atbl%3A14%3Aj_id21=&j_id3%3Atbl%3A15%3Aattribute=Name%2015&j_id3%3Atbl%3A15%3AreplySuggestions_selection=&j_id3%3Atbl%3A15%3Aj_id9=&j_id3%3Atbl%3A15%3Aj_id21=&j_id3%3Atbl%3A16%3Aattribute=Name%2016&j_id3%3Atbl%3A16%3AreplySuggestions_selection=&j_id3%3Atbl%3A16%3Aj_id9=&j_id3%3Atbl%3A16%3Aj_id21=&j_id3%3Atbl%3A17%3Aattribute=Name%2017&j_id3%3Atbl%3A17%3AreplySuggestions_selection=&j_id3%3Atbl%3A17%3Aj_id9=&j_id3%3Atbl%3A17%3Aj_id21=&j_id3%3Atbl%3A18%3Aattribute=Name%2018&j_id3%3Atbl%3A18%3AreplySuggestions_selection=&j_id3%3Atbl%3A18%3Aj_id9=&j_id3%3Atbl%3A18%3Aj_id21=&j_id3%3Atbl%3A19%3Aattribute=Name%2019&j_id3%3Atbl%3A19%3AreplySuggestions_selection=&j_id3%3Atbl%3A19%3Aj_id9=&j_id3%3Atbl%3A19%3Aj_id21=&j_id3%3Atbl%3A20%3Aattribute=Name%2020&j_id3%3Atbl%3A20%3AreplySuggestions_selection=&j_id3%3Atbl%3A20%3Aj_id9=&j_id3%3Atbl%3A20%3Aj_id21=&j_id3%3Atbl%3A21%3Aattribute=Name%2021&j_id3%3Atbl%3A21%3AreplySuggestions_selection=&j_id3%3Atbl%3A21%3Aj_id9=&j_id3%3Atbl%3A21%3Aj_id21=&j_id3%3Atbl%3A22%3Aattribute=Name%2022&j_id3%3Atbl%3A22%3AreplySuggestions_selection=&j_id3%3Atbl%3A22%3Aj_id9=&j_id3%3Atbl%3A22%3Aj_id21=&j_id3%3Atbl%3A23%3Aattribute=Name%2023&j_id3%3Atbl%3A23%3AreplySuggestions_selection=&j_id3%3Atbl%3A23%3Aj_id9=&j_id3%3Atbl%3A23%3Aj_id21=&j_id3%3Atbl%3A24%3Aattribute=Name%2024&j_id3%3Atbl%3A24%3AreplySuggestions_selection=&j_id3%3Atbl%3A24%3Aj_id9=&j_id3%3Atbl%3A24%3Aj_id21=&j_id3%3Atbl%3A25%3Aattribute=Name%2025&j_id3%3Atbl%3A25%3AreplySuggestions_selection=&j_id3%3Atbl%3A25%3Aj_id9=&j_id3%3Atbl%3A25%3Aj_id21=&j_id3%3Atbl%3A26%3Aattribute=Name%2026&j_id3%3Atbl%3A26%3AreplySuggestions_selection=&j_id3%3Atbl%3A26%3Aj_id9=&j_id3%3Atbl%3A26%3Aj_id21=&j_id3%3Atbl%3A27%3Aattribute=Name%2027&j_id3%3Atbl%3A27%3AreplySuggestions_selection=&j_id3%3Atbl%3A27%3Aj_id9=&j_id3%3Atbl%3A27%3Aj_id21=&j_id3%3Atbl%3A28%3Aattribute=Name%2028&j_id3%3Atbl%3A28%3AreplySuggestions_selection=&j_id3%3Atbl%3A28%3Aj_id9=&j_id3%3Atbl%3A28%3Aj_id21=&j_id3%3Atbl%3A29%3Aattribute=Name%2029&j_id3%3Atbl%3A29%3AreplySuggestions_selection=&j_id3%3Atbl%3A29%3Aj_id9=&j_id3%3Atbl%3A29%3Aj_id21=&javax.faces.ViewState=j_id1&j_id3%3Atbl%3A0%3AreplySuggestions=j_id3%3Atbl%3A0%3AreplySuggestions&ajaxSingle=j_id3%3Atbl%3A0%3AreplySuggestions&inputvalue=Name%200h&AJAX%3AEVENTS_COUNT=1&
                    debug[1:04:46,563]: Reqest state : 2
                    debug[1:04:46,565]: Reqest state : 3
                    debug[1:04:46,566]: Reqest state : 4
                    debug[1:04:46,567]: Reqest end with state 4
                    debug[1:04:46,568]: Response with content-type: text/xml;charset=UTF-8


                    Ok, please try to get rid of these concurrent requests and check then.