<?xml version="1.0" encoding="UTF-8"?>
<rss xmlns:content="http://purl.org/rss/1.0/modules/content/" xmlns:dc="http://purl.org/dc/elements/1.1/" xmlns:rdf="http://www.w3.org/1999/02/22-rdf-syntax-ns#" xmlns:taxo="http://purl.org/rss/1.0/modules/taxonomy/" version="2.0">
  <channel>
    <title>topic Web Scripts executing slowly in Alfresco Archive</title>
    <link>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271410#M224540</link>
    <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hi, I am currently working on moving our alfresco server from a local Ubuntu VM to a RHEL5 VM at our datacenter.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;So far everything has worked great, except for one script that execute when metadata is added to a document in a specific folder. &lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;This script:&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;PRE class="language-none line-numbers"&gt;&lt;CODE&gt;var descT = '';&lt;BR /&gt;var fieldA = ['Onum','PO'];&lt;BR /&gt;&lt;BR /&gt;for (var j=0; j&amp;lt;fieldA.length ;j++) &lt;BR /&gt;&amp;nbsp;&amp;nbsp; {&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; var curField = document.properties[("kb:"+ fieldA[j])];&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; if(curField&amp;nbsp; !== undefined &amp;amp;&amp;amp; curField&amp;nbsp; !== ''&amp;nbsp; &amp;amp;&amp;amp; curField&amp;nbsp; !== null)&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; {&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; var query = 'PATH:"/app:company_home/st:sites/cm:Operations/cm:documentLibrary//*"'+ 'AND ASPECT:"kb:referencable" AND ';&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; query+= '@kb\\:' + fieldA[j]+ ':\" ' + curField + ' \"';&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; var searchRes = search.luceneSearch(query);&lt;BR /&gt;&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; for (var i=1; i&amp;lt;searchRes.length; i++)&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; {&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; if (searchRes[0].properties[("kb:"+ fieldA[j])] == searchRes[i].properties[("kb:"+ fieldA[j])] )&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; { if(descT!==''){descT += ' and ';};&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; descT += fieldA[j] + ':&amp;nbsp; ' + searchRes[i].properties[("kb:"+ fieldA[j])]+ '\r\n';}&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; }&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; }&lt;BR /&gt;&amp;nbsp;&amp;nbsp; }&lt;BR /&gt;&lt;BR /&gt;&lt;BR /&gt;if(descT=='')&lt;BR /&gt;{&lt;BR /&gt; document.removeAspect("kb:dupli");&lt;BR /&gt; if(document.properties["kb:Otype"] == 'PO')&lt;BR /&gt; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("01. POs to Sort")); }&lt;BR /&gt; &lt;BR /&gt;&amp;nbsp; if(document.properties["kb:Otype"] == 'Easy Order')&lt;BR /&gt; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("02. Easy Orders to Enter")); }&lt;BR /&gt; &lt;BR /&gt;&amp;nbsp; if(document.properties["kb:Otype"] == 'Tradeshow')&lt;BR /&gt; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("04. TS Orders to Enter")); }&lt;BR /&gt; &lt;BR /&gt;&amp;nbsp; if(document.properties["kb:Otype"] == 'Workshop')&lt;BR /&gt; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("03. WS Orders to Enter")); }&lt;BR /&gt; &lt;BR /&gt;&amp;nbsp; if(document.properties["kb:Otype"] == 'N/A')&lt;BR /&gt; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("04. Other Orders to Enter")); }&lt;BR /&gt;}else&lt;BR /&gt;{&lt;BR /&gt;&amp;nbsp; if(document.properties["kb:DupIgn"] == true)&lt;BR /&gt; {&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; document.removeAspect("kb:dupli");&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp; if(document.properties["kb:Otype"] == 'PO')&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("01. POs to Sort")); }&lt;BR /&gt;&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; if(document.properties["kb:Otype"] == 'Easy Order')&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("02. Easy Orders to Enter")); }&lt;BR /&gt;&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; if(document.properties["kb:Otype"] == 'Tradeshow')&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("04. TS Orders to Enter")); }&lt;BR /&gt;&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; if(document.properties["kb:Otype"] == 'Workshop')&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("03. WS Orders to Enter")); }&lt;BR /&gt;&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; if(document.properties["kb:Otype"] == 'N/A')&lt;BR /&gt;&amp;nbsp;&amp;nbsp;&amp;nbsp; {&amp;nbsp; document.move(space.parent.childByNamePath("02. Orders to Enter").childByNamePath("04. Other Orders to Enter")); }&lt;BR /&gt; }else&lt;BR /&gt; {&lt;BR /&gt;&amp;nbsp; descT = '' + descT;&lt;BR /&gt;&amp;nbsp; document.properties["kb:DupRecord"] = descT;&lt;BR /&gt;&amp;nbsp; var newDesc = new Array(1);&lt;BR /&gt;&amp;nbsp; newDesc ["kb:DupRecord"] = descT;&lt;BR /&gt;&amp;nbsp; if(document.hasAspect("kb:dupli") == false)&lt;BR /&gt; { document.addAspect("kb:dupli", newDesc);}&lt;BR /&gt; }&lt;BR /&gt;}&lt;BR /&gt;&amp;nbsp; document.save();&lt;BR /&gt;&lt;SPAN class="line-numbers-rows"&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;/SPAN&gt;&lt;/CODE&gt;&lt;/PRE&gt;&lt;BR /&gt;&lt;SPAN&gt;Checks for duplicates and also moves the document to the appropriate folder based off the data in the metadata.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;The problem I'm having is that on the current live server it executes immediately, but on the test server it takes 10 seconds to run (I've verified this through debug logs).&amp;nbsp; Any idea what may be causing this?&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Here is the log from the Test Server when the script is executed:&lt;/SPAN&gt;&lt;BR /&gt;&lt;PRE class="language-none line-numbers"&gt;&lt;CODE&gt;11:15:20,209 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Writing Transactional response: size=144647&lt;BR /&gt;11:15:20,209 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient] Response status code: 200&lt;BR /&gt;11:15:20,209 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient] Response encoding: Content-Type: application/x-shockwave-flash;charset=UTF-8&lt;BR /&gt;&lt;BR /&gt;11:15:20,210 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Authentication reset: unauthenticated&lt;BR /&gt;11:15:20,210 DEBUG [org.springframework.extensions.webscripts.AbstractRuntime] Web Script org/alfresco/repository/thumbnail/thumbnail.get executed in 15.045ms&lt;BR /&gt;11:15:20,210 DEBUG [org.springframework.extensions.webscripts.AbstractRuntime] Processed script url (GET) /api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/content/thumbnails/webpreview in 15.306ms&lt;BR /&gt;11:15:20,315 DEBUG [org.springframework.extensions.webscripts.connector.AuthenticatingConnector] Received 200 on first call to: /api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/content/thumbnails/webpreview?c=force&amp;amp;noCacheToken=1343664920715&lt;BR /&gt;11:15:20,315 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController] Return code: 200&lt;BR /&gt;11:15:29,207 DEBUG [org.alfresco.repo.activities.feed.local.LocalFeedGenerator] &amp;gt;&amp;gt;&amp;gt; No work to be done for this job cycle: local&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController] EndPointProxyController preparing to proxy:&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController]&amp;nbsp; - endpointId: alfresco&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController]&amp;nbsp; - userId: admin&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController]&amp;nbsp; - connector: &lt;A href="http://localhost:8080/alfresco/s" rel="nofollow noopener noreferrer"&gt;http://localhost:8080/alfresco/s&lt;/A&gt; - {cleartextUsername=admin, cleartextPassword=admin}&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController]&amp;nbsp; - method: POST&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController]&amp;nbsp; - url: /api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient] Executing (POST) &lt;A href="http://localhost:8080/alfresco/s/api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor?alf_ticket=TICKET_4c5e844c1ac9b09a77f1ae3b1142ae197ac641fc" rel="nofollow noopener noreferrer"&gt;http://localhost:8080/alfresco/s/api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor?alf_ticket=TICKET_4c5e844c1ac9b09a77f1ae3b1142ae197ac641fc&lt;/A&gt;&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient]&amp;nbsp; - InputStream supplied - will push…&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient]&amp;nbsp; - OutputStream supplied - will stream response…&lt;BR /&gt;11:15:36,865 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient]&amp;nbsp; - Full Proxy mode between servlet request and response…&lt;BR /&gt;11:15:36,866 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient] Set content-type=application/json&lt;BR /&gt;11:15:36,866 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient] POST entity content-length=117&lt;BR /&gt;11:15:36,867 DEBUG [org.springframework.extensions.webscripts.servlet.WebScriptServlet] Processing request (POST) &lt;A href="http://localhost:8080/alfresco/s/api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor?alf_ticket=TICKET_4c5e844c1ac9b09a77f1ae3b1142ae197ac641fc" rel="nofollow noopener noreferrer"&gt;http://localhost:8080/alfresco/s/api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor?alf_ticket=TICKET_4c5e844c1ac9b09a77f1ae3b1142ae197ac641fc&lt;/A&gt;&lt;BR /&gt;11:15:36,867 DEBUG [org.springframework.extensions.webscripts.AbstractRuntime] (Runtime=ServletRuntime, Container=Repository) Processing script url (POST) /api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor&lt;BR /&gt;11:15:36,867 DEBUG [org.springframework.extensions.webscripts.servlet.WebScriptServletRequest] Content Type: application/json&lt;BR /&gt;11:15:36,867 DEBUG [org.springframework.extensions.webscripts.AbstractRuntime] Agent: null&lt;BR /&gt;11:15:36,867 DEBUG [org.springframework.extensions.webscripts.AbstractRuntime] Invoking Web Script org/alfresco/repository/forms/form.post (format json, style: any, default: json)&lt;BR /&gt;11:15:36,867 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Current authentication: unauthenticated&lt;BR /&gt;11:15:36,867 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Authentication required: user&lt;BR /&gt;11:15:36,867 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Guest login requested: false&lt;BR /&gt;11:15:36,867 DEBUG [org.alfresco.repo.web.scripts.servlet.BasicHttpAuthenticatorFactory$BasicHttpAuthenticator] HTTP Authorization provided: false&lt;BR /&gt;11:15:36,867 DEBUG [org.alfresco.repo.web.scripts.servlet.BasicHttpAuthenticatorFactory$BasicHttpAuthenticator] URL ticket provided: true&lt;BR /&gt;11:15:36,867 DEBUG [org.alfresco.repo.web.scripts.servlet.BasicHttpAuthenticatorFactory$BasicHttpAuthenticator] Authenticating (URL argument) ticket TICKET_4c5e844c1ac9b09a77f1ae3b1142ae197ac641fc&lt;BR /&gt;11:15:36,872 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Authentication: authenticated as admin&lt;BR /&gt;11:15:36,872 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Begin retry transaction block: required,readwrite&lt;BR /&gt;11:15:36,872 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Creating Transactional Response for ReadWrite transaction; buffersize=4096&lt;BR /&gt;11:15:36,872 DEBUG [org.springframework.extensions.webscripts.DeclarativeWebScript] Executing script classpath*:alfresco/extension/templates/webscripts/org/alfresco/repository/forms/form.post.json.js&lt;BR /&gt;11:15:36,875 DEBUG [org.alfresco.repo.jscript.ScriptLogger] json form submission for item:&lt;BR /&gt;11:15:36,875 DEBUG [org.alfresco.repo.jscript.ScriptLogger]&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; kind = node&lt;BR /&gt;11:15:36,875 DEBUG [org.alfresco.repo.jscript.ScriptLogger]&amp;nbsp;&amp;nbsp;&amp;nbsp;&amp;nbsp; id = workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42&lt;BR /&gt;11:15:36,877 DEBUG [org.alfresco.repo.forms.FormServiceImpl] Saving form for item '[node]workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42': org.alfresco.repo.forms.FormData@6da8e1ac (data={prop_kb_Otype=org.alfresco.repo.forms.FormData$FieldData@6a781b72 (name=prop_kb_Otype, value=PO, isFile=false), prop_kb_CheqNo=org.alfresco.repo.forms.FormData$FieldData@73520ff9 (name=prop_kb_CheqNo, value=, isFile=false), prop_kb_PO=org.alfresco.repo.forms.FormData$FieldData@1096df95 (name=prop_kb_PO, value=7984687461, isFile=false), prop_kb_Company=org.alfresco.repo.forms.FormData$FieldData@2130b7b5 (name=prop_kb_Company, value=Test, isFile=false), prop_kb_Zcode=org.alfresco.repo.forms.FormData$FieldData@56cdd19 (name=prop_kb_Zcode, value=68114, isFile=false)})&lt;BR /&gt;11:15:36,877 DEBUG [org.alfresco.repo.forms.processor.AbstractFormProcessor] Checking processor org.alfresco.repo.forms.processor.node.NodeFormProcessor@14c55ea (active=true, matchPattern=node) for applicability for item '[node]workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42', result = true&lt;BR /&gt;11:15:36,877 DEBUG [org.alfresco.repo.forms.processor.FormProcessorRegistry] Returning applicable processor: org.alfresco.repo.forms.processor.node.NodeFormProcessor@14c55ea (active=true, matchPattern=node)&lt;BR /&gt;11:15:36,877 DEBUG [org.alfresco.repo.forms.processor.FilterRegistry] Returning active filters: []&lt;BR /&gt;11:15:36,877 DEBUG [org.alfresco.repo.forms.processor.node.NodeFormProcessor] Persisting form for: workspace://SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42&lt;BR /&gt;11:15:36,878 DEBUG [org.alfresco.repo.forms.processor.node.NodeFormProcessor] Processing field org.alfresco.repo.forms.FormData$FieldData@6a781b72 (name=prop_kb_Otype, value=PO, isFile=false) for property persistence&lt;BR /&gt;11:15:36,878 DEBUG [org.alfresco.repo.forms.processor.node.NodeFormProcessor] Processing field org.alfresco.repo.forms.FormData$FieldData@73520ff9 (name=prop_kb_CheqNo, value=, isFile=false) for property persistence&lt;BR /&gt;11:15:36,878 DEBUG [org.alfresco.repo.forms.processor.node.NodeFormProcessor] Processing field org.alfresco.repo.forms.FormData$FieldData@1096df95 (name=prop_kb_PO, value=7984687461, isFile=false) for property persistence&lt;BR /&gt;11:15:36,878 DEBUG [org.alfresco.repo.forms.processor.node.NodeFormProcessor] Processing field org.alfresco.repo.forms.FormData$FieldData@2130b7b5 (name=prop_kb_Company, value=Test, isFile=false) for property persistence&lt;BR /&gt;11:15:36,878 DEBUG [org.alfresco.repo.forms.processor.node.NodeFormProcessor] Processing field org.alfresco.repo.forms.FormData$FieldData@56cdd19 (name=prop_kb_Zcode, value=68114, isFile=false) for property persistence&lt;BR /&gt;11:15:36,973 DEBUG [org.alfresco.repo.forms.processor.FilterRegistry] Returning active filters: []&lt;BR /&gt;11:15:36,973 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Time to execute script: 98.793ms&lt;BR /&gt;11:15:36,973 DEBUG [org.springframework.extensions.webscripts.AbstractWebScript] Executed script classpath*:alfresco/extension/templates/webscripts/org/alfresco/repository/forms/form.post.json.js in 98.907ms&lt;BR /&gt;11:15:36,974 DEBUG [org.springframework.extensions.webscripts.servlet.WebScriptServletResponse] Cache - set response header Cache-Control: no-cache&lt;BR /&gt;11:15:36,974 DEBUG [org.springframework.extensions.webscripts.servlet.WebScriptServletResponse] Cache - set response header Pragma: no-cache&lt;BR /&gt;11:15:36,974 DEBUG [org.springframework.extensions.webscripts.DeclarativeWebScript] Rendering response: content type=application/json, status=200&lt;BR /&gt;11:15:36,974 DEBUG [org.springframework.extensions.webscripts.DeclarativeWebScript] Rendering template 'org/alfresco/repository/forms/form.post.json'&lt;BR /&gt;11:15:36,976 DEBUG [org.springframework.extensions.webscripts.AbstractWebScript] Rendered template org/alfresco/repository/forms/form.post.json in 1.626ms&lt;BR /&gt;11:15:36,976 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] End retry transaction block: required,readwrite&lt;BR /&gt;11:15:36,984 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Imports resolved, adding resource '_root&lt;BR /&gt;11:15:37,003 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Time to execute script: 16.451ms&lt;BR /&gt;11:15:37,012 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Imports resolved, adding resource '_root&lt;BR /&gt;11:15:37,025 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Time to execute script: 11.76ms&lt;BR /&gt;11:15:37,034 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Imports resolved, adding resource '_root&lt;BR /&gt;11:15:47,041 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Time to execute script: 10001.479ms&lt;BR /&gt;11:15:47,048 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Imports resolved, adding resource '_root&lt;BR /&gt;11:15:47,065 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Time to execute script: 13.987ms&lt;BR /&gt;11:15:47,074 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Imports resolved, adding resource '_root&lt;BR /&gt;11:15:47,089 DEBUG [org.alfresco.repo.jscript.RhinoScriptProcessor] Time to execute script: 13.267ms&lt;BR /&gt;11:15:47,200 DEBUG [org.alfresco.repo.web.scripts.RepositoryContainer] Authentication reset: unauthenticated&lt;BR /&gt;11:15:47,200 DEBUG [org.springframework.extensions.webscripts.AbstractRuntime] Web Script org/alfresco/repository/forms/form.post executed in 10332.5ms&lt;BR /&gt;11:15:47,200 DEBUG [org.springframework.extensions.webscripts.AbstractRuntime] Processed script url (POST) /api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor in 10332.734ms&lt;BR /&gt;11:15:47,200 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient] Response status code: 200&lt;BR /&gt;11:15:47,200 DEBUG [org.springframework.extensions.webscripts.connector.RemoteClient] Response encoding: Content-Type: application/json;charset=UTF-8&lt;BR /&gt;&lt;BR /&gt;11:15:47,200 DEBUG [org.springframework.extensions.webscripts.connector.AuthenticatingConnector] Received 200 on first call to: /api/node/workspace/SpacesStore/db9c77c5-739a-43b3-bdd2-d7be1347af42/formprocessor&lt;BR /&gt;11:15:47,201 DEBUG [org.springframework.extensions.webscripts.servlet.mvc.EndPointProxyController] Return code: 200&lt;BR /&gt;&lt;SPAN class="line-numbers-rows"&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;SPAN&gt;‍&lt;/SPAN&gt;&lt;/SPAN&gt;&lt;/CODE&gt;&lt;/PRE&gt;&lt;BR /&gt;&lt;SPAN&gt;Here are the specs for the two servers:&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Live:&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;Ubuntu 10.04.4&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;4GB RAM&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;100GB VHD (92% used)&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;4 core CPU&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Test (will be live when finished):&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;RHEL 5&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;8GB RAM&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;8 core CPU&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;300GB VHD&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
    <pubDate>Mon, 30 Jul 2012 16:16:53 GMT</pubDate>
    <dc:creator>eagledelta1</dc:creator>
    <dc:date>2012-07-30T16:16:53Z</dc:date>
    <item>
      <title>Web Scripts executing slowly</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271410#M224540</link>
      <description>Hi, I am currently working on moving our alfresco server from a local Ubuntu VM to a RHEL5 VM at our datacenter.So far everything has worked great, except for one script that execute when metadata is added to a document in a specific folder. This script:var descT = '';var fieldA = ['Onum','PO'];for</description>
      <pubDate>Mon, 30 Jul 2012 16:16:53 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271410#M224540</guid>
      <dc:creator>eagledelta1</dc:creator>
      <dc:date>2012-07-30T16:16:53Z</dc:date>
    </item>
    <item>
      <title>Re: Web Scripts executing slowly</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271411#M224541</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Is there no one with any sort of answer, suggestion or even question?&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Tue, 31 Jul 2012 17:53:24 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271411#M224541</guid>
      <dc:creator>eagledelta1</dc:creator>
      <dc:date>2012-07-31T17:53:24Z</dc:date>
    </item>
    <item>
      <title>Re: Web Scripts executing slowly</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271412#M224542</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;Hello,&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;you should keep in mind that Lucene PATH queries, especially one for "..//*", can take a very long time depending on the state, content and I/O performance of the index. Until there is more information, I'd bet on this as my most-likely suspect, since you perform this type of search in a loop none the less.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;I'd suggest adding some logging to your web script in order to measure what individual part of it executes slowly. So, you should at least put some simple log statements at the begin and end of your loop, and before / after you execute the search.&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Regards&lt;/SPAN&gt;&lt;BR /&gt;&lt;SPAN&gt;Axel&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Wed, 01 Aug 2012 07:51:59 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271412#M224542</guid>
      <dc:creator>afaust</dc:creator>
      <dc:date>2012-08-01T07:51:59Z</dc:date>
    </item>
    <item>
      <title>Re: Web Scripts executing slowly</title>
      <link>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271413#M224543</link>
      <description>&lt;HTML&gt;&lt;HEAD&gt;&lt;/HEAD&gt;&lt;BODY&gt;&lt;SPAN&gt;It may also be worth you experimenting with removing that path statement - or do you have other sites containing kb:referenceable?&lt;/SPAN&gt;&lt;BR /&gt;&lt;BR /&gt;&lt;SPAN&gt;Another approach is to use 4.0 and SOLR which doesn't have the problems with paths.&lt;/SPAN&gt;&lt;/BODY&gt;&lt;/HTML&gt;</description>
      <pubDate>Wed, 01 Aug 2012 08:56:24 GMT</pubDate>
      <guid>https://connect.hyland.com/t5/alfresco-archive/web-scripts-executing-slowly/m-p/271413#M224543</guid>
      <dc:creator>mrogers</dc:creator>
      <dc:date>2012-08-01T08:56:24Z</dc:date>
    </item>
  </channel>
</rss>

