Hyland Community
Help
cancel
Turn on suggestions
Showing results for 
Search instead for 
Did you mean: 

Create content of custom type Tutorial not working

anujcb
Confirmed Champ
Confirmed Champ

‎04-14-2015 11:55 AM

Hi,

  I was trying out the tutorial "Create content of custom type". When I run the sample I get the following error. I have community edition ver 5.

When I go to the URL "http://localhost:8080/alfresco/service/modeltest/MyWhitepaper  "  I get the below exception. I am a newbie to Alfresco.

Thanks
Anil


Alfresco Web Script Status 500 - Internal Error


The Web Script /alfresco/service/modeltest/MyWhitepaper has responded with a status of 500 - Internal Error.


500 Description: An error inside the HTTP server which prevented it from fulfilling the request.
 
Message: 03140001 Cannot locate template processor for template modeltest.get.html
  
Exception: org.springframework.extensions.webscripts.WebScriptException - 03140001 Cannot locate template processor for template modeltest.get.html
  
org.springframework.extensions.webscripts.AbstractWebScript.renderTemplate(AbstractWebScript.java:963)
org.springframework.extensions.webscripts.DeclarativeWebScript.renderFormatTemplate(DeclarativeWebScript.java:267)
org.springframework.extensions.webscripts.DeclarativeWebScript.execute(DeclarativeWebScript.java:147)
org.alfresco.repo.web.scripts.RepositoryContainer$3.execute(RepositoryContainer.java:470)
org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:454)
org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecute(RepositoryContainer.java:532)
org.alfresco.repo.web.scripts.RepositoryContainer.transactionedExecuteAs(RepositoryContainer.java:600)
org.alfresco.repo.web.scripts.RepositoryContainer.executeScriptInternal(RepositoryContainer.java:380)
org.alfresco.repo.web.scripts.RepositoryContainer.executeScript(RepositoryContainer.java:261)
org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:378)
org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:209)
org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:132)
javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
org.alfresco.web.app.servlet.GlobalLocalizationFilter.doFilter(GlobalLocalizationFilter.java:61)
org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:501)
org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:98)
org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950)
org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:408)
org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1040)
org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:607)
org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.doRun(AprEndpoint.java:2441)
org.apache.tomcat.util.net.AprEndpoint$SocketProcessor.run(AprEndpoint.java:2430)
java.util.concurrent.ThreadPoolExecutor.runWorker(Unknown Source)
java.util.concurrent.ThreadPoolExecutor$Worker.run(Unknown Source)
java.lang.Thread.run(Unknown Source)
  
Server: Community v5.0.0 (c r91299-b145) schema 8,009
Time: Apr 14, 2015 8:54:20 AM
  
Diagnostics: Inspect Web Script (modeltest.get)
Labels:
0 Kudos
6 REPLIES 6

anujcb
Confirmed Champ
Confirmed Champ

‎04-17-2015 01:54 AM

Any pointers will be much appreciated!
0 Kudos

sihnu
Champ in-the-making
Champ in-the-making

‎04-17-2015 07:55 AM

Could you post the content of your ftl template and probably description file as well (yourwebscriptname.get.desc.xml)?
0 Kudos

mrogers
Star Contributor
Star Contributor

‎04-17-2015 07:57 AM

No help is possible from the few details that you have posted so far.
0 Kudos

anujcb
Confirmed Champ
Confirmed Champ

‎04-17-2015 11:26 AM

modeltest.get.desc.xml

<webscript>   <shortname>Model test</shortname>   <family>Tutorials</family>   <description>Creates content of a custom type</description>   <url>/modeltest/{documentName}</url>   <format default="html">extension</format>   <authentication>user</authentication></webscript> ‍‍‍‍‍‍‍‍‍‍‍


modeltest.get.html.ftl

<p>Creating the following document:</p><ul>   <li>${document.name}</li>   <li>${document.type}</li></ul><b>${msg}</b>‍‍‍‍‍‍‍‍

modeltest.get.js
var contentType = "my:whitepaper";var documentName = url.templateArgs.documentName;var document = companyhome.createNode(documentName, contentType);if (document != null){   model.document = document;   model.msg = "Created OK!";}else {   model.msg = "Failed to create document!";}‍‍‍‍‍‍‍‍‍‍‍‍‍‍

custom-model-context.xml
<?xml version='1.0' encoding='UTF-8'?><!DOCTYPE beans PUBLIC '-//SPRING//DTD BEAN//EN' 'http://www.springframework.org/dtd/spring-beans.dtd'> <beans>    <!– Registration of new models –>       <bean id="custommodel.dictionaryBootstrap" parent="dictionaryModelBootstrap" depends-on="dictionaryBootstrap">        <property name="models">            <list>                <value>alfresco/extension/customModel.xml</value>            </list>        </property>    </bean>          </beans>‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

customModel.xml
<?xml version="1.0" encoding="UTF-8"?><!– Definition of new Model –><!– The important part here is the name - Note: the use of the my: namespace    which is defined further on in the document –><model name="my:custommodel" xmlns="http://www.alfresco.org/model/dictionary/1.0">   <!– Optional meta-data about the model –>   <description>Example Custom Model</description>   <author>Alfresco Documentation Team</author>   <version>1.0</version>   <!– Imports are required to allow references to definitions in other models –>   <imports>      <!– Import Alfresco Dictionary Definitions –>      <import uri="http://www.alfresco.org/model/dictionary/1.0"         prefix="d" />      <!– Import Alfresco Content Domain Model Definitions –>      <import uri="http://www.alfresco.org/model/content/1.0" prefix="cm" />   </imports>   <!– Introduction of new namespaces defined by this model –>   <!– NOTE: The following namespace my.new.model should be changed to reflect       your own namespace –>   <namespaces>      <namespace uri="http://www.mycompany.com/model/content/1.0"         prefix="my" />   </namespaces>   <constraints>      <constraint name="my:productListConstraint" type="LIST">         <parameter name="allowedValues">            <list>               <value>Foobar Widget</value>               <value>Flux Capacitor</value>               <value>Big Bold App</value>            </list>         </parameter>      </constraint>   </constraints>   <types>      <!– Enterprise-wide generic document type –>      <type name="my:doc">         <title>MyCompany Generic Document</title>         <parent>cm:content</parent>      </type>      <type name="my:marketingDoc">         <title>MyCompany Marketing Document</title>         <parent>my:doc</parent>         <properties>            <property name="my:product">               <type>d:text</type>               <multiple>true</multiple>               <constraints>                  <constraint ref="my:productListConstraint" />               </constraints>            </property>         </properties>      </type>      <type name="my:whitepaper">         <title>MyCompany Whitepaper</title>         <parent>my:marketingDoc</parent>      </type>   </types></model>                ‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍
0 Kudos

anujcb
Confirmed Champ
Confirmed Champ

‎04-18-2015 03:16 AM

I deleted the .js file and recreated it. Could have been some weird character in it.
0 Kudos

vivekthakur21
Champ in-the-making
Champ in-the-making
In response to anujcb

‎08-17-2015 07:17 AM

Same error or issue, i am getting today. My cataline.out file says -

Aug 17, 2015 1:40:49 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /Users/vthakur/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
Aug 17, 2015 1:40:49 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:40:49 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:40:49 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:40:49 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 471 ms
Aug 17, 2015 1:40:49 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 17, 2015 1:40:49 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 17, 2015 1:40:49 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 17, 2015 1:40:49 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 17, 2015 1:40:53 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-17 13:40:54,840  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-17 13:40:54,840  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-17 13:40:54,924  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
2015-08-17 13:40:54,935  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 10 ms
Aug 17, 2015 1:40:54 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deployment of configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml has finished in 5,320 ms
Aug 17, 2015 1:40:54 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 17, 2015 1:40:55 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war has finished in 74 ms
Aug 17, 2015 1:40:55 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 17, 2015 1:41:00 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 1:41:00 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 13:41:03,311  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbcSmiley Tongueostgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-17 13:41:03,448  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-17 13:41:07,353  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 13:41:07,378  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-17 13:41:07,387  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-17 13:41:12,348  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-17 13:41:12,350  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-17 13:41:13,770  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 13:41:13,803  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-17 13:41:13,836  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbcSmiley Tongueostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-17 13:41:13,836  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-17 13:41:13,901  WARN  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema validation found 83 potential problems, results written to: /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-PostgreSQLDialect-Validation-Pre-Upgrade-alf_-3826940159227613176.txt
2015-08-17 13:41:13,911  WARN  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema validation found 28 potential problems, results written to: /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-PostgreSQLDialect-Validation-Pre-Upgrade-jbpm_-3688433195156515609.txt
2015-08-17 13:41:13,921  WARN  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema validation found 25 potential problems, results written to: /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-PostgreSQLDialect-Validation-Pre-Upgrade-act_-5077024892309581050.txt
2015-08-17 13:41:13,979  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Normalized schema dumped to file /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-schema-PostgreSQLDialect-pre-upgrade-alf_-2659361196375369190.xml.
2015-08-17 13:41:13,979  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Normalized schema dumped to file /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-schema-PostgreSQLDialect-pre-upgrade-jbpm_-2330025405927670566.xml.
2015-08-17 13:41:13,980  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Normalized schema dumped to file /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-schema-PostgreSQLDialect-pre-upgrade-act_-1192591704732619633.xml.
2015-08-17 13:41:13,982  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-7244849896188384903.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-RepoTables.sql).
2015-08-17 13:41:14,134  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-8469879371803992104.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-LockTables.sql).
2015-08-17 13:41:14,147  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-4730267994857237452.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ContentTables.sql).
2015-08-17 13:41:14,176  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-8606558376554544325.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-PropertyValueTables.sql).
2015-08-17 13:41:14,225  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-431862852653342559.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ContentUrlEncryptionTables.sql).
2015-08-17 13:41:14,233  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-6678299659732607136.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-AuditTables.sql).
2015-08-17 13:41:14,259  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3892552823660653712.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ActivityTables.sql).
2015-08-17 13:41:14,280  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-910471791219474624.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-UsageTables.sql).
2015-08-17 13:41:14,286  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-360711563792582709.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-SubscriptionTables.sql).
2015-08-17 13:41:14,291  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-1196259507232521855.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-TenantTables.sql).
2015-08-17 13:41:14,393  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-2219634393011878071.sql (Generated).
2015-08-17 13:41:14,589  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-787115855343598164.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-Extra.sql).
2015-08-17 13:41:14,591  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-2789817146727316252.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-FK-indexes.sql).
2015-08-17 13:41:14,666  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-7141215488333161131.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-varinst-indexes.sql).
2015-08-17 13:41:14,668  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Create scripts executed in 813 ms
2015-08-17 13:41:15,002  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] All executed statements:  /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-All_Statements-196774730479567769.sql.
2015-08-17 13:41:17,133  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Compared database schema with reference schema (all OK): class path resource [alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/Schema-Reference-ALF.xml]
2015-08-17 13:41:18,405  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Compared database schema with reference schema (all OK): class path resource [alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/Schema-Reference-JBPM.xml]
2015-08-17 13:41:19,481  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Compared database schema with reference schema (all OK): class path resource [alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/Schema-Reference-ACT.xml]
2015-08-17 13:41:23,873  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Normalized schema dumped to file /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-schema-PostgreSQLDialect-post-upgrade-alf_-6065547931805081470.xml.
2015-08-17 13:41:23,873  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Normalized schema dumped to file /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-schema-PostgreSQLDialect-post-upgrade-jbpm_-5420918433228660980.xml.
2015-08-17 13:41:23,873  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Normalized schema dumped to file /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/Alfresco-schema-PostgreSQLDialect-post-upgrade-act_-6361538662903579855.xml.
2015-08-17 13:41:24,274  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 13:41:24,463  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-17 13:41:29,097  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 13:41:29,201  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-17 13:41:30,386  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Creating time limited trial license
2015-08-17 13:41:30,517  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-17 13:41:30,526  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 13:41:30,595  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-17 13:41:30,595  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 13:41:30,636  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-17 13:41:30,736  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-17 13:41:30,736  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 1:41:30 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 17, 2015 1:41:30 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 1:41:30 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice 3.6 command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 1:41:30 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 17, 2015 1:41:30 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: starting process with acceptString 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1' and profileDir '/Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100'
Aug 17, 2015 1:41:30 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 17, 2015 1:41:32 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-17 13:41:32,377  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-17 13:41:32,379  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-17 13:41:32,383  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /Applications/alfresco-5.0.1.5/alf_data
2015-08-17 13:41:32,393  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-17 13:41:32,475  WARN  [admin.patch.PatchExecuter] [localhost-startStop-1] Patch description is not available: Patch[ id=patch.contentFormFolderType, description=patch.contentFormFolderType.description, fixesFromSchema=0, fixesToSchema=36, targetSchema=37, ignored=false]
2015-08-17 13:41:32,491  WARN  [admin.patch.PatchExecuter] [localhost-startStop-1] Patch description is not available: Patch[ id=patch.redeploySubmitProcess, description=patch.redeploySubmitProcess.description, fixesFromSchema=0, fixesToSchema=57, targetSchema=58, ignored=false]
2015-08-17 13:41:32,770  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]    Applying patch 'patch.siteLoadPatch.swsdp' (Loads a sample site into the repository.).
2015-08-17 13:41:35,116  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]    Applying patch 'patch.exampleJavaScript' (Loads sample Javascript file into datadictionary scripts folder).
2015-08-17 13:41:35,163  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V3.4-UsageTables
RESULT:
Script completed
=====================================
2015-08-17 13:41:35,163  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V4.0-TenantTables
RESULT:
Script completed
=====================================
2015-08-17 13:41:35,163  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V3.4-JBPM-varinst-indexes
RESULT:
Script completed
=====================================
2015-08-17 13:41:35,163  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V5.0-ContentUrlEncryptionTables
RESULT:
Script completed
=====================================
2015-08-17 13:41:35,163  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.siteLoadPatch.swsdp
RESULT:
Site swsdp imported.
=====================================
2015-08-17 13:41:35,163  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.exampleJavaScript
RESULT:
Imported view into bootstrap location: /app:company_home/app:dictionary/app:scripts (workspace://SpacesStore/058f5bcf-e122-4cc5-b0ac-8590287914da)
=====================================
2015-08-17 13:41:35,182  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-17 13:41:35,203  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Installing module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-17 13:41:35,217  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 13:41:35,456  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-17 13:41:35,466  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
2015-08-17 13:41:35,471  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-17 13:41:35,472  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-17 13:41:35,486  ERROR [org.alfresco.fileserver] [CIFS Server] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
2015-08-17 13:41:35,489  ERROR [org.alfresco.fileserver] [CIFS Server] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
   at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
   at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
   at java.lang.Thread.run(Thread.java:745)
2015-08-17 13:41:35,558  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-17 13:41:35,559  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-17 13:41:35,604  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-17 13:41:35,604  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-17 13:41:35,652  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-17 13:41:35,652  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 13:41:35,664  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-17 13:41:35,678  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 13:41:35,747  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-17 13:41:35,770  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-17 13:41:35,779  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Wed Sep 16 00:00:00 IST 2015 (30 days remaining).
2015-08-17 13:41:35,779  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-17 13:41:35,779  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Enterprise). Current version: 5.0.1 (.5 r108957-b87) schema 8,022. Originally installed version: 5.0.1 (.5 r108957-b87) schema 8,022.
2015-08-17 13:41:35,787  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 13:41:35,944  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-17 13:41:35,944  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-17 13:41:35,955  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-17 13:41:36,834  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 13:41:36,899  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-17 13:41:38,890  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:41:38,891  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:41:38,891  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:41:40,050  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:41:40,050  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:41:40,050  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:41:40,051  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3125.4578ms)
2015-08-17 13:41:40,064  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:41:40,068  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:41:41,133  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:41:41,133  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:41:41,133  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:41:41,171  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:41:41,172  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:41:41,172  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:41:41,259  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:41:41,259  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:41:41,259  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:41:41,260  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1156.049ms)
2015-08-17 13:41:41,290  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:41:41,290  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:41:41,290  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 1:41:41 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 17, 2015 1:41:43 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 17, 2015 1:41:43 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war has finished in 48,666 ms
Aug 17, 2015 1:41:43 PM org.apache.catalina.core.StandardContext setPath
WARNING: A context path must either be an empty string or start with a '/' and do not end with a '/'. The path [/] does not meet these criteria and has been changed to []
Aug 17, 2015 1:41:43 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 17, 2015 1:41:43 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 17, 2015 1:41:43 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war has finished in 59 ms
Aug 17, 2015 1:41:43 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 17, 2015 1:41:47 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 1:41:47 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 13:41:51,048  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:41:51,051  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:41:51,051  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:41:51,052  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:41:51,957  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-17 13:41:51,957  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-17 13:41:51,957  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:41:52,031  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 978.45374ms)
2015-08-17 13:41:52,057  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:41:52,058  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 17, 2015 1:41:52 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 17, 2015 1:41:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 1:41:52 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war has finished in 8,488 ms
Aug 17, 2015 1:41:52 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 17, 2015 1:41:52 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager has finished in 41 ms
Aug 17, 2015 1:41:52 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 17, 2015 1:41:52 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager has finished in 37 ms
Aug 17, 2015 1:41:52 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:41:52 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:41:52 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:41:52 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 62734 ms
2015-08-17 13:42:03,660  INFO  [web.site.EditionInterceptor] [http-bio-8080-exec-4] Successfully retrieved license information from Alfresco.
2015-08-17 13:42:11,785  INFO  [web.scripts.ImapServerStatus] [http-bio-8080-exec-4] Successfully retrieved IMAP server status from Alfresco: disabled
2015-08-17 13:42:11,923  INFO  [web.scripts.SyncModeConfig] [http-bio-8080-exec-4] Successfully retrieved Sync Mode configuration from Alfresco: OFF
2015-08-17 13:42:15,067  INFO  [management.subsystems.ChildApplicationContextFactory] [http-bio-8443-exec-3] Starting 'Transformers' subsystem, ID: [Transformers, default]
2015-08-17 13:42:15,319  INFO  [management.subsystems.ChildApplicationContextFactory] [http-bio-8443-exec-3] Startup of 'Transformers' subsystem, ID: [Transformers, default] complete
2015-08-17 13:42:26,981  INFO  [web.scripts.DictionaryQuery] [http-bio-8080-exec-4] Successfully retrieved Data Dictionary from Alfresco.
2015-08-17 13:44:05,017  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-6] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:44:05,017  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-6] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:44:05,017  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-6] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:44:05,018  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-6] Initialised Repository Web Script Container (in 1231.4344ms)
2015-08-17 13:44:06,123  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:44:06,123  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:44:06,123  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 1:52:36 PM org.apache.catalina.core.StandardServer await
INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance.
Aug 17, 2015 1:52:36 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:52:36 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:52:36 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:52:36 PM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
Aug 17, 2015 1:52:36 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate destroy
INFO: WSSERVLET15: JAX-WS servlet destroyed
Aug 17, 2015 1:52:36 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextDestroyed
INFO: WSSERVLET13: JAX-WS context listener destroyed
Aug 17, 2015 1:52:36 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
2015-08-17 13:52:36,442  INFO  [cluster.core.ClusteringBootstrap] [localhost-startStop-2] Clustering has shutdown.
2015-08-17 13:52:36,467  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 13:52:36,468  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 13:52:36,475  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Replication' subsystem, ID: [Replication, default]
2015-08-17 13:52:36,476  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Replication' subsystem, ID: [Replication, default]
2015-08-17 13:52:36,485  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 13:52:36,487  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 13:52:36,487  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, inbound]
2015-08-17 13:52:36,488  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, inbound]
2015-08-17 13:52:36,488  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 13:52:36,490  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 13:52:36,501  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 1:52:36 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopping
Aug 17, 2015 1:52:36 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 17, 2015 1:52:36 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 17, 2015 1:52:36 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopped
2015-08-17 13:52:36,786  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
2015-08-17 13:52:36,798  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 13:52:36,798  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 13:52:36,799  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'solrSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:52:36,799  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'activitiesSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:52:36,799  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 13:52:36,800  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 13:52:36,800  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 13:52:36,800  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 13:52:36,802  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 13:52:36,802  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 13:52:36,802  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, outbound]
2015-08-17 13:52:36,803  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, outbound]
2015-08-17 13:52:36,803  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'imap' subsystem, ID: [imap, default]
2015-08-17 13:52:36,804  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'imap' subsystem, ID: [imap, default]
2015-08-17 13:52:37,258  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 13:52:37,729  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 13:52:37,793  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'locksSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:52:37,794  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'propertyValueSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:52:37,795  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 13:52:37,795  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 13:52:37,796  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Transformers' subsystem, ID: [Transformers, default]
2015-08-17 13:52:37,796  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Transformers' subsystem, ID: [Transformers, default]
2015-08-17 13:52:37,796  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'auditSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:52:37,798  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 13:52:37,799  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 13:52:37,799  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'contentSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:52:37,800  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 13:52:37,800  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 13:52:37,803  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'repoSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
Aug 17, 2015 1:52:37 PM org.apache.catalina.core.ApplicationContext log
INFO: Shutting down log4j
Aug 17, 2015 1:52:37 PM org.apache.catalina.core.ApplicationContext log
INFO: Destroying Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 1:52:37 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
Aug 17, 2015 1:52:37 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
Aug 17, 2015 1:52:39 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:52:39 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:52:39 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:52:39 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:52:39 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:52:39 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:53:53 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /Users/vthakur/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
Aug 17, 2015 1:53:53 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:53:53 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:53:53 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:53:53 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 472 ms
Aug 17, 2015 1:53:53 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 17, 2015 1:53:53 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 17, 2015 1:53:53 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 17, 2015 1:53:53 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 17, 2015 1:53:56 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-17 13:53:58,298  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-17 13:53:58,299  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-17 13:53:58,378  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
Aug 17, 2015 1:53:58 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deployment of configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml has finished in 5,104 ms
Aug 17, 2015 1:53:58 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 17, 2015 1:53:58 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war has finished in 76 ms
Aug 17, 2015 1:53:58 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
2015-08-17 13:53:58,694  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 316 ms
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 17, 2015 1:54:03 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 1:54:03 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 13:54:05,953  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbcSmiley Tongueostgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-17 13:54:06,078  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-17 13:54:10,041  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 13:54:10,061  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-17 13:54:10,072  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-17 13:54:15,220  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-17 13:54:15,222  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-17 13:54:16,937  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 13:54:16,962  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-17 13:54:16,998  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbcSmiley Tongueostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-17 13:54:16,998  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-17 13:54:18,195  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
2015-08-17 13:54:18,792  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 13:54:18,894  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-17 13:54:19,416  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-17 13:54:19,424  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 13:54:19,509  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-17 13:54:19,509  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 13:54:19,560  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-17 13:54:19,671  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-17 13:54:19,671  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 1:54:19 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 17, 2015 1:54:19 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 1:54:19 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice 3.6 command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 1:54:19 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 17, 2015 1:54:19 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: starting process with acceptString 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1' and profileDir '/Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100'
Aug 17, 2015 1:54:19 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 17, 2015 1:54:21 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-17 13:54:21,567  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-17 13:54:21,570  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-17 13:54:21,576  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /Applications/alfresco-5.0.1.5/alf_data
2015-08-17 13:54:21,576  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 13:54:21,795  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-17 13:54:21,800  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-17 13:54:22,041  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2015-08-17 13:54:22,056  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-17 13:54:22,080  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-17 13:54:22,085  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 13:54:22,419  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-17 13:54:22,433  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
2015-08-17 13:54:22,439  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-17 13:54:22,439  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-17 13:54:22,454  ERROR [org.alfresco.fileserver] [CIFS Server] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
2015-08-17 13:54:22,458  ERROR [org.alfresco.fileserver] [CIFS Server] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
   at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
   at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
   at java.lang.Thread.run(Thread.java:745)
2015-08-17 13:54:22,518  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-17 13:54:22,518  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-17 13:54:22,564  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-17 13:54:22,564  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-17 13:54:22,629  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-17 13:54:22,629  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 13:54:22,643  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-17 13:54:22,665  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 13:54:22,763  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-17 13:54:22,801  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-17 13:54:22,821  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Wed Sep 16 00:00:00 IST 2015 (30 days remaining).
2015-08-17 13:54:22,821  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-17 13:54:22,821  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Enterprise). Current version: 5.0.1 (.5 r108957-b87) schema 8,022. Originally installed version: 5.0.1 (.5 r108957-b87) schema 8,022.
2015-08-17 13:54:22,832  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 13:54:22,999  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-17 13:54:22,999  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-17 13:54:23,012  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-17 13:54:23,860  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 13:54:23,950  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-17 13:54:26,488  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:54:26,489  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:54:26,489  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:54:27,902  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:54:27,902  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:54:27,903  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:54:27,907  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3923.4568ms)
2015-08-17 13:54:27,923  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:54:27,925  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:54:29,216  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:54:29,216  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:54:29,216  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:54:29,268  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:54:29,268  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:54:29,268  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:54:29,321  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:54:29,321  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:54:29,321  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:54:29,322  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1359.1241ms)
2015-08-17 13:54:29,351  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:54:29,351  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:54:29,351  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 1:54:29 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 17, 2015 1:54:31 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 17, 2015 1:54:32 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war has finished in 33,538 ms
Aug 17, 2015 1:54:32 PM org.apache.catalina.core.StandardContext setPath
WARNING: A context path must either be an empty string or start with a '/' and do not end with a '/'. The path [/] does not meet these criteria and has been changed to []
Aug 17, 2015 1:54:32 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 17, 2015 1:54:32 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 17, 2015 1:54:32 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war has finished in 52 ms
Aug 17, 2015 1:54:32 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 17, 2015 1:54:33 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 1:54:33 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 13:54:36,958  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:54:36,962  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:54:36,962  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:54:36,963  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:54:37,830  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-17 13:54:37,830  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-17 13:54:37,830  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:54:37,874  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 910.84937ms)
2015-08-17 13:54:37,894  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:54:37,894  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 17, 2015 1:54:38 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 17, 2015 1:54:38 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 1:54:38 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war has finished in 6,002 ms
Aug 17, 2015 1:54:38 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 17, 2015 1:54:38 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager has finished in 41 ms
Aug 17, 2015 1:54:38 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 17, 2015 1:54:38 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager has finished in 33 ms
Aug 17, 2015 1:54:38 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:54:38 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:54:38 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:54:38 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 44893 ms
2015-08-17 13:54:52,323  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-3] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:54:52,324  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-3] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:54:52,324  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-3] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:54:52,326  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-3] Initialised Repository Web Script Container (in 1404.8228ms)
2015-08-17 13:54:53,563  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:54:53,563  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:54:53,563  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 1:57:31 PM org.apache.catalina.core.StandardServer await
INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance.
Aug 17, 2015 1:57:31 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:57:31 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:57:31 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:57:31 PM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
Aug 17, 2015 1:57:31 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate destroy
INFO: WSSERVLET15: JAX-WS servlet destroyed
Aug 17, 2015 1:57:31 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextDestroyed
INFO: WSSERVLET13: JAX-WS context listener destroyed
Aug 17, 2015 1:57:31 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
2015-08-17 13:57:31,688  INFO  [cluster.core.ClusteringBootstrap] [localhost-startStop-2] Clustering has shutdown.
2015-08-17 13:57:31,713  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 13:57:31,714  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 13:57:31,721  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Replication' subsystem, ID: [Replication, default]
2015-08-17 13:57:31,722  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Replication' subsystem, ID: [Replication, default]
2015-08-17 13:57:31,749  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 13:57:31,750  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 13:57:31,751  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, inbound]
2015-08-17 13:57:31,751  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, inbound]
2015-08-17 13:57:31,752  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 13:57:31,756  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 13:57:31,766  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 1:57:31 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopping
Aug 17, 2015 1:57:31 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 17, 2015 1:57:32 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 17, 2015 1:57:32 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopped
2015-08-17 13:57:32,040  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
2015-08-17 13:57:32,053  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 13:57:32,056  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 13:57:32,057  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'solrSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:57:32,058  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'activitiesSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:57:32,058  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 13:57:32,058  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 13:57:32,058  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 13:57:32,059  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 13:57:32,060  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 13:57:32,061  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 13:57:32,061  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, outbound]
2015-08-17 13:57:32,061  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, outbound]
2015-08-17 13:57:32,062  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'imap' subsystem, ID: [imap, default]
2015-08-17 13:57:32,062  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'imap' subsystem, ID: [imap, default]
2015-08-17 13:57:32,550  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 13:57:32,904  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 13:57:32,962  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'locksSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:57:32,963  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'propertyValueSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:57:32,964  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 13:57:32,965  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 13:57:32,965  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'auditSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:57:32,967  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 13:57:32,967  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 13:57:32,968  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'contentSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 13:57:32,968  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 13:57:32,969  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 13:57:32,971  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'repoSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
Aug 17, 2015 1:57:32 PM org.apache.catalina.core.ApplicationContext log
INFO: Shutting down log4j
Aug 17, 2015 1:57:32 PM org.apache.catalina.core.ApplicationContext log
INFO: Destroying Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 1:57:33 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
Aug 17, 2015 1:57:33 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
Aug 17, 2015 1:57:35 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:57:35 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:57:35 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:57:35 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:57:35 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:57:35 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:58:12 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /Users/vthakur/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
Aug 17, 2015 1:58:12 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:58:12 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:58:12 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:58:12 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 466 ms
Aug 17, 2015 1:58:12 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 17, 2015 1:58:12 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 17, 2015 1:58:12 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 17, 2015 1:58:12 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 17, 2015 1:58:15 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-17 13:58:17,650  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-17 13:58:17,650  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-17 13:58:17,725  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
Aug 17, 2015 1:58:17 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deployment of configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml has finished in 5,139 ms
Aug 17, 2015 1:58:17 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 17, 2015 1:58:17 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war has finished in 95 ms
Aug 17, 2015 1:58:17 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
2015-08-17 13:58:17,978  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 253 ms
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 17, 2015 1:58:22 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 1:58:22 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 13:58:25,403  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbcSmiley Tongueostgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-17 13:58:25,535  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-17 13:58:29,719  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 13:58:29,740  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-17 13:58:29,752  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-17 13:58:35,025  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-17 13:58:35,026  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-17 13:58:36,538  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 13:58:36,559  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-17 13:58:36,592  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbcSmiley Tongueostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-17 13:58:36,592  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-17 13:58:37,849  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
2015-08-17 13:58:38,450  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 13:58:38,554  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-17 13:58:39,049  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-17 13:58:39,058  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 13:58:39,139  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-17 13:58:39,139  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 13:58:39,191  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-17 13:58:39,312  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-17 13:58:39,312  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 1:58:39 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 17, 2015 1:58:39 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 1:58:39 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice 3.6 command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 1:58:39 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 17, 2015 1:58:39 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: starting process with acceptString 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1' and profileDir '/Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100'
Aug 17, 2015 1:58:39 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 17, 2015 1:58:40 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-17 13:58:40,952  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-17 13:58:40,955  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-17 13:58:40,960  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /Applications/alfresco-5.0.1.5/alf_data
2015-08-17 13:58:40,960  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 13:58:41,181  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-17 13:58:41,186  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-17 13:58:41,435  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2015-08-17 13:58:41,454  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-17 13:58:41,477  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-17 13:58:41,481  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 13:58:41,784  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-17 13:58:41,795  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
2015-08-17 13:58:41,801  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-17 13:58:41,802  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-17 13:58:41,819  ERROR [org.alfresco.fileserver] [CIFS Server] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
2015-08-17 13:58:41,824  ERROR [org.alfresco.fileserver] [CIFS Server] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
   at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
   at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
   at java.lang.Thread.run(Thread.java:745)
2015-08-17 13:58:41,883  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-17 13:58:41,883  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-17 13:58:41,931  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-17 13:58:41,931  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-17 13:58:42,002  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-17 13:58:42,002  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 13:58:42,021  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-17 13:58:42,041  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 13:58:42,150  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-17 13:58:42,184  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-17 13:58:42,202  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Wed Sep 16 00:00:00 IST 2015 (30 days remaining).
2015-08-17 13:58:42,202  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-17 13:58:42,203  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Enterprise). Current version: 5.0.1 (.5 r108957-b87) schema 8,022. Originally installed version: 5.0.1 (.5 r108957-b87) schema 8,022.
2015-08-17 13:58:42,212  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 13:58:42,388  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-17 13:58:42,388  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-17 13:58:42,399  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-17 13:58:43,229  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 13:58:43,300  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-17 13:58:45,724  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:58:45,725  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:58:45,725  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:58:47,190  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:58:47,190  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:58:47,190  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:58:47,192  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3860.3384ms)
2015-08-17 13:58:47,207  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:58:47,209  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:58:48,463  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:58:48,463  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:58:48,463  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:58:48,514  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:58:48,514  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:58:48,515  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:58:48,603  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:58:48,603  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:58:48,603  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:58:48,604  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1355.6085ms)
2015-08-17 13:58:48,634  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 13:58:48,634  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 13:58:48,634  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 1:58:48 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 17, 2015 1:58:50 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 17, 2015 1:58:51 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war has finished in 33,346 ms
Aug 17, 2015 1:58:51 PM org.apache.catalina.core.StandardContext setPath
WARNING: A context path must either be an empty string or start with a '/' and do not end with a '/'. The path [/] does not meet these criteria and has been changed to []
Aug 17, 2015 1:58:51 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 17, 2015 1:58:51 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 17, 2015 1:58:51 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war has finished in 55 ms
Aug 17, 2015 1:58:51 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 17, 2015 1:58:52 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 1:58:52 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 13:58:56,341  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:58:56,347  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:58:56,348  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:58:56,349  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 13:58:57,254  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-17 13:58:57,254  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-17 13:58:57,254  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:58:57,323  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 973.7298ms)
2015-08-17 13:58:57,342  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 13:58:57,343  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 17, 2015 1:58:57 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 17, 2015 1:58:57 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 1:58:57 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war has finished in 6,292 ms
Aug 17, 2015 1:58:57 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 17, 2015 1:58:57 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager has finished in 43 ms
Aug 17, 2015 1:58:57 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 17, 2015 1:58:57 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager has finished in 37 ms
Aug 17, 2015 1:58:57 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 1:58:57 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 1:58:57 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 1:58:57 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 45054 ms
2015-08-17 13:58:59,285  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:58:59,285  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:58:59,286  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:58:59,288  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-1] Initialised Repository Web Script Container (in 1349.1797ms)
2015-08-17 13:59:00,598  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:59:00,598  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:59:00,598  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:59:37,390  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-8] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:59:37,391  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-8] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:59:37,391  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-8] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 13:59:37,392  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-8] Initialised Repository Web Script Container (in 1187.6396ms)
2015-08-17 13:59:38,494  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 13:59:38,494  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 13:59:38,494  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 2:03:23 PM org.apache.catalina.core.StandardServer await
INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance.
Aug 17, 2015 2:03:23 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:03:23 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:03:23 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:03:23 PM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
Aug 17, 2015 2:03:23 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate destroy
INFO: WSSERVLET15: JAX-WS servlet destroyed
Aug 17, 2015 2:03:23 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextDestroyed
INFO: WSSERVLET13: JAX-WS context listener destroyed
Aug 17, 2015 2:03:23 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
2015-08-17 14:03:23,509  INFO  [cluster.core.ClusteringBootstrap] [localhost-startStop-2] Clustering has shutdown.
2015-08-17 14:03:23,529  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 14:03:23,533  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 14:03:23,542  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Replication' subsystem, ID: [Replication, default]
2015-08-17 14:03:23,543  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Replication' subsystem, ID: [Replication, default]
2015-08-17 14:03:23,557  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 14:03:23,559  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 14:03:23,559  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, inbound]
2015-08-17 14:03:23,560  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, inbound]
2015-08-17 14:03:23,560  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 14:03:23,564  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 14:03:23,565  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 2:03:23 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopping
Aug 17, 2015 2:03:23 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 17, 2015 2:03:23 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 17, 2015 2:03:23 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopped
2015-08-17 14:03:23,838  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
2015-08-17 14:03:23,864  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 14:03:23,865  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 14:03:23,865  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'solrSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:03:23,866  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'activitiesSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:03:23,866  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 14:03:23,867  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 14:03:23,867  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 14:03:23,867  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 14:03:23,870  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 14:03:23,871  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 14:03:23,871  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, outbound]
2015-08-17 14:03:23,871  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, outbound]
2015-08-17 14:03:23,872  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'imap' subsystem, ID: [imap, default]
2015-08-17 14:03:23,874  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'imap' subsystem, ID: [imap, default]
2015-08-17 14:03:24,402  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 14:03:24,901  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 14:03:24,959  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'locksSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:03:24,960  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'propertyValueSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:03:24,961  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 14:03:24,962  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 14:03:24,962  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'auditSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:03:24,964  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 14:03:24,964  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 14:03:24,964  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'contentSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:03:24,965  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 14:03:24,966  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 14:03:24,968  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'repoSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
Aug 17, 2015 2:03:24 PM org.apache.catalina.core.ApplicationContext log
INFO: Shutting down log4j
Aug 17, 2015 2:03:24 PM org.apache.catalina.core.ApplicationContext log
INFO: Destroying Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 2:03:25 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
Aug 17, 2015 2:03:25 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
Aug 17, 2015 2:03:56 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:03:56 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:03:56 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:03:56 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:03:56 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:03:56 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:04:08 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /Users/vthakur/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
Aug 17, 2015 2:04:08 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:04:08 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:04:08 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:04:08 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 476 ms
Aug 17, 2015 2:04:08 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 17, 2015 2:04:08 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 17, 2015 2:04:08 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 17, 2015 2:04:08 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 17, 2015 2:04:11 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-17 14:04:13,320  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-17 14:04:13,320  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-17 14:04:13,396  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
Aug 17, 2015 2:04:13 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deployment of configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml has finished in 4,983 ms
Aug 17, 2015 2:04:13 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 17, 2015 2:04:13 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war has finished in 85 ms
Aug 17, 2015 2:04:13 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
2015-08-17 14:04:13,658  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 261 ms
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 17, 2015 2:04:18 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 2:04:18 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 14:04:20,595  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbcSmiley Tongueostgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-17 14:04:20,749  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-17 14:04:24,625  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 14:04:24,646  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-17 14:04:24,656  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-17 14:04:29,601  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-17 14:04:29,603  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-17 14:04:31,036  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 14:04:31,063  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-17 14:04:31,095  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbcSmiley Tongueostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-17 14:04:31,095  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-17 14:04:32,301  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
2015-08-17 14:04:32,905  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 14:04:33,006  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-17 14:04:33,505  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-17 14:04:33,513  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 14:04:33,589  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-17 14:04:33,589  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 14:04:33,635  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-17 14:04:33,749  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-17 14:04:33,749  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 2:04:33 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 17, 2015 2:04:33 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 2:04:33 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice 3.6 command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 2:04:33 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 17, 2015 2:04:33 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: starting process with acceptString 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1' and profileDir '/Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100'
Aug 17, 2015 2:04:33 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 17, 2015 2:04:35 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-17 14:04:35,407  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-17 14:04:35,409  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-17 14:04:35,414  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /Applications/alfresco-5.0.1.5/alf_data
2015-08-17 14:04:35,414  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 14:04:35,603  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-17 14:04:35,612  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-17 14:04:35,814  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2015-08-17 14:04:35,828  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-17 14:04:35,846  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-17 14:04:35,850  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 14:04:36,116  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-17 14:04:36,126  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
2015-08-17 14:04:36,132  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-17 14:04:36,132  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-17 14:04:36,147  ERROR [org.alfresco.fileserver] [CIFS Server] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
2015-08-17 14:04:36,150  ERROR [org.alfresco.fileserver] [CIFS Server] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
   at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
   at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
   at java.lang.Thread.run(Thread.java:745)
2015-08-17 14:04:36,199  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-17 14:04:36,199  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-17 14:04:36,244  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-17 14:04:36,244  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-17 14:04:36,286  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-17 14:04:36,286  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 14:04:36,317  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-17 14:04:36,338  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 14:04:36,429  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-17 14:04:36,470  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-17 14:04:36,486  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Wed Sep 16 00:00:00 IST 2015 (30 days remaining).
2015-08-17 14:04:36,487  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-17 14:04:36,487  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Enterprise). Current version: 5.0.1 (.5 r108957-b87) schema 8,022. Originally installed version: 5.0.1 (.5 r108957-b87) schema 8,022.
2015-08-17 14:04:36,496  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 14:04:36,670  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-17 14:04:36,670  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-17 14:04:36,684  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-17 14:04:37,461  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 14:04:37,528  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-17 14:04:39,698  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:04:39,699  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:04:39,699  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:04:40,994  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:04:40,994  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:04:40,994  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:04:40,996  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3440.4438ms)
2015-08-17 14:04:41,008  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:04:41,010  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 14:04:42,169  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:04:42,169  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:04:42,169  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:04:42,213  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 14:04:42,213  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 14:04:42,213  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:04:42,306  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 14:04:42,306  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 14:04:42,306  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:04:42,307  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1262.0895ms)
2015-08-17 14:04:42,336  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 14:04:42,336  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 14:04:42,336  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 2:04:42 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 17, 2015 2:04:44 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 17, 2015 2:04:44 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war has finished in 31,196 ms
Aug 17, 2015 2:04:44 PM org.apache.catalina.core.StandardContext setPath
WARNING: A context path must either be an empty string or start with a '/' and do not end with a '/'. The path [/] does not meet these criteria and has been changed to []
Aug 17, 2015 2:04:44 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 17, 2015 2:04:44 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 17, 2015 2:04:44 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war has finished in 64 ms
Aug 17, 2015 2:04:44 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 17, 2015 2:04:46 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 2:04:46 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 14:04:49,485  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:04:49,488  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 14:04:49,489  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:04:49,490  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 14:04:50,318  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-17 14:04:50,318  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-17 14:04:50,318  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:04:50,365  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 875.6115ms)
2015-08-17 14:04:50,383  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:04:50,384  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 17, 2015 2:04:50 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 17, 2015 2:04:50 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 2:04:50 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war has finished in 5,790 ms
Aug 17, 2015 2:04:50 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 17, 2015 2:04:50 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager has finished in 40 ms
Aug 17, 2015 2:04:50 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 17, 2015 2:04:50 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager has finished in 38 ms
Aug 17, 2015 2:04:50 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:04:50 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:04:50 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:04:50 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 42244 ms
2015-08-17 14:04:59,172  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:04:59,172  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:04:59,173  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:04:59,179  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-1] Initialised Repository Web Script Container (in 1396.6688ms)
2015-08-17 14:05:00,473  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:05:00,473  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:05:00,473  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:05:07,011  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-4] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:05:07,012  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-4] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:05:07,012  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-4] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:05:07,013  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-4] Initialised Repository Web Script Container (in 1197.7144ms)
2015-08-17 14:05:08,117  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:05:08,117  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:05:08,117  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:10:19,088  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-9] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:10:19,088  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-9] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:10:19,089  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-9] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:10:19,090  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-9] Initialised Repository Web Script Container (in 1242.6438ms)
2015-08-17 14:10:20,125  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:10:20,125  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:10:20,125  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 2:17:55 PM org.apache.catalina.core.StandardServer await
INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance.
Aug 17, 2015 2:17:55 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:17:55 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:17:55 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:17:55 PM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
Aug 17, 2015 2:17:55 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate destroy
INFO: WSSERVLET15: JAX-WS servlet destroyed
Aug 17, 2015 2:17:55 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextDestroyed
INFO: WSSERVLET13: JAX-WS context listener destroyed
Aug 17, 2015 2:17:55 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
2015-08-17 14:17:55,469  INFO  [cluster.core.ClusteringBootstrap] [localhost-startStop-2] Clustering has shutdown.
2015-08-17 14:17:55,490  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 14:17:55,493  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 14:17:55,503  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Replication' subsystem, ID: [Replication, default]
2015-08-17 14:17:55,504  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Replication' subsystem, ID: [Replication, default]
2015-08-17 14:17:55,518  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 14:17:55,520  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 14:17:55,520  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, inbound]
2015-08-17 14:17:55,521  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, inbound]
2015-08-17 14:17:55,521  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 14:17:55,524  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 14:17:55,525  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 2:17:55 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopping
Aug 17, 2015 2:17:55 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 17, 2015 2:17:55 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 17, 2015 2:17:55 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopped
2015-08-17 14:17:55,803  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
2015-08-17 14:17:55,817  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 14:17:55,818  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 14:17:55,818  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'solrSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:17:55,819  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'activitiesSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:17:55,819  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 14:17:55,819  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 14:17:55,820  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 14:17:55,820  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 14:17:55,822  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 14:17:55,822  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 14:17:55,822  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, outbound]
2015-08-17 14:17:55,823  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, outbound]
2015-08-17 14:17:55,823  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'imap' subsystem, ID: [imap, default]
2015-08-17 14:17:55,824  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'imap' subsystem, ID: [imap, default]
2015-08-17 14:17:56,307  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 14:17:56,522  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 14:17:56,587  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'locksSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:17:56,588  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'propertyValueSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:17:56,589  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 14:17:56,590  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 14:17:56,590  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'auditSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:17:56,592  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 14:17:56,593  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 14:17:56,593  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'contentSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 14:17:56,594  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 14:17:56,595  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 14:17:56,597  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'repoSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
Aug 17, 2015 2:17:56 PM org.apache.catalina.core.ApplicationContext log
INFO: Shutting down log4j
Aug 17, 2015 2:17:56 PM org.apache.catalina.core.ApplicationContext log
INFO: Destroying Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 2:17:56 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
Aug 17, 2015 2:17:56 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
Aug 17, 2015 2:17:58 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:17:58 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:17:58 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:17:58 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:17:58 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:17:58 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:18:38 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /Users/vthakur/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
Aug 17, 2015 2:18:39 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:18:39 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:18:39 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:18:39 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 468 ms
Aug 17, 2015 2:18:39 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 17, 2015 2:18:39 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 17, 2015 2:18:39 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 17, 2015 2:18:39 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 17, 2015 2:18:42 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-17 14:18:44,247  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-17 14:18:44,247  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-17 14:18:44,321  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
Aug 17, 2015 2:18:44 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deployment of configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml has finished in 5,080 ms
Aug 17, 2015 2:18:44 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 17, 2015 2:18:44 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war has finished in 89 ms
Aug 17, 2015 2:18:44 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
2015-08-17 14:18:44,584  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 263 ms
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 17, 2015 2:18:49 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 2:18:49 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 14:18:51,619  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbcSmiley Tongueostgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-17 14:18:51,744  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-17 14:18:55,686  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 14:18:55,707  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-17 14:18:55,716  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-17 14:19:00,984  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-17 14:19:01,004  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-17 14:19:02,614  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 14:19:02,639  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-17 14:19:02,683  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbcSmiley Tongueostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-17 14:19:02,683  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-17 14:19:03,909  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
2015-08-17 14:19:04,502  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 14:19:04,610  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-17 14:19:05,100  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-17 14:19:05,110  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 14:19:05,191  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-17 14:19:05,191  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 14:19:05,242  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-17 14:19:05,353  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-17 14:19:05,353  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 2:19:05 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 17, 2015 2:19:05 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 2:19:05 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice 3.6 command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 2:19:05 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 17, 2015 2:19:05 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: starting process with acceptString 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1' and profileDir '/Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100'
Aug 17, 2015 2:19:05 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 17, 2015 2:19:06 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-17 14:19:06,998  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-17 14:19:07,000  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-17 14:19:07,005  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /Applications/alfresco-5.0.1.5/alf_data
2015-08-17 14:19:07,005  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 14:19:07,225  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-17 14:19:07,230  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-17 14:19:07,469  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2015-08-17 14:19:07,489  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-17 14:19:07,508  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-17 14:19:07,513  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 14:19:07,815  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-17 14:19:07,831  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-17 14:19:07,831  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-17 14:19:07,845  ERROR [org.alfresco.fileserver] [CIFS Server] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
2015-08-17 14:19:07,850  ERROR [org.alfresco.fileserver] [CIFS Server] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
   at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
   at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
   at java.lang.Thread.run(Thread.java:745)
2015-08-17 14:19:07,911  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-17 14:19:07,911  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-17 14:19:07,961  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-17 14:19:07,961  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-17 14:19:08,005  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-17 14:19:08,005  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 14:19:08,023  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-17 14:19:08,052  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 14:19:08,161  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-17 14:19:08,199  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-17 14:19:08,219  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Wed Sep 16 00:00:00 IST 2015 (30 days remaining).
2015-08-17 14:19:08,220  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-17 14:19:08,220  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Enterprise). Current version: 5.0.1 (.5 r108957-b87) schema 8,022. Originally installed version: 5.0.1 (.5 r108957-b87) schema 8,022.
2015-08-17 14:19:08,232  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 14:19:08,404  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-17 14:19:08,404  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-17 14:19:08,420  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-17 14:19:09,188  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 14:19:09,254  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-17 14:19:11,414  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:19:11,414  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:19:11,414  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:19:12,766  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:19:12,766  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:19:12,766  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:19:12,769  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3486.2751ms)
2015-08-17 14:19:12,789  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:19:12,790  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 14:19:13,974  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:19:13,974  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:19:13,974  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:19:14,017  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 14:19:14,017  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 14:19:14,017  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:19:14,104  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 14:19:14,104  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 14:19:14,104  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:19:14,106  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1269.8888ms)
2015-08-17 14:19:14,134  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 14:19:14,134  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 14:19:14,134  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 2:19:14 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 17, 2015 2:19:16 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 17, 2015 2:19:16 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war has finished in 32,078 ms
Aug 17, 2015 2:19:16 PM org.apache.catalina.core.StandardContext setPath
WARNING: A context path must either be an empty string or start with a '/' and do not end with a '/'. The path [/] does not meet these criteria and has been changed to []
Aug 17, 2015 2:19:16 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 17, 2015 2:19:16 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 17, 2015 2:19:16 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war has finished in 44 ms
Aug 17, 2015 2:19:16 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 17, 2015 2:19:17 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 2:19:17 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 14:19:21,172  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:19:21,175  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 14:19:21,176  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:19:21,177  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 14:19:22,025  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-17 14:19:22,025  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-17 14:19:22,025  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:19:22,076  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 899.57837ms)
2015-08-17 14:19:22,094  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 14:19:22,094  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 17, 2015 2:19:22 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 17, 2015 2:19:22 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 2:19:22 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war has finished in 5,711 ms
Aug 17, 2015 2:19:22 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 17, 2015 2:19:22 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager has finished in 44 ms
Aug 17, 2015 2:19:22 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 17, 2015 2:19:22 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager has finished in 35 ms
Aug 17, 2015 2:19:22 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 2:19:22 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 2:19:22 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 2:19:22 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 43124 ms
2015-08-17 14:20:25,707  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-2] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:20:25,708  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-2] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:20:25,708  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-2] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 14:20:25,709  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-2] Initialised Repository Web Script Container (in 1300.8969ms)
2015-08-17 14:20:26,851  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 14:20:26,851  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 14:20:26,851  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:04:58,827  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-7] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:04:58,827  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-7] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:04:58,827  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-7] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:04:58,829  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-7] Initialised Repository Web Script Container (in 1242.0018ms)
2015-08-17 16:04:59,928  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:04:59,928  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:04:59,928  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:21:09,553  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:21:09,553  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:21:09,553  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:21:09,555  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-1] Initialised Repository Web Script Container (in 1278.8969ms)
2015-08-17 16:21:10,691  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:21:10,691  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:21:10,691  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 4:29:31 PM org.apache.catalina.core.StandardServer await
INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance.
Aug 17, 2015 4:29:31 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:29:31 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:29:31 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:29:31 PM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
Aug 17, 2015 4:29:31 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate destroy
INFO: WSSERVLET15: JAX-WS servlet destroyed
Aug 17, 2015 4:29:31 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextDestroyed
INFO: WSSERVLET13: JAX-WS context listener destroyed
Aug 17, 2015 4:29:31 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
2015-08-17 16:29:31,984  INFO  [cluster.core.ClusteringBootstrap] [localhost-startStop-2] Clustering has shutdown.
2015-08-17 16:29:32,003  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 16:29:32,005  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 16:29:32,014  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Replication' subsystem, ID: [Replication, default]
2015-08-17 16:29:32,015  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Replication' subsystem, ID: [Replication, default]
2015-08-17 16:29:32,025  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 16:29:32,025  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 16:29:32,026  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, inbound]
2015-08-17 16:29:32,027  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, inbound]
2015-08-17 16:29:32,027  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 16:29:32,041  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 16:29:32,041  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 4:29:32 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopping
Aug 17, 2015 4:29:32 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 17, 2015 4:29:32 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 17, 2015 4:29:32 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopped
2015-08-17 16:29:32,319  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
2015-08-17 16:29:32,337  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 16:29:32,338  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 16:29:32,338  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'solrSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:29:32,339  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'activitiesSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:29:32,339  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 16:29:32,340  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 16:29:32,340  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 16:29:32,340  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 16:29:32,343  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 16:29:32,343  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 16:29:32,344  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, outbound]
2015-08-17 16:29:32,344  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, outbound]
2015-08-17 16:29:32,345  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'imap' subsystem, ID: [imap, default]
2015-08-17 16:29:32,346  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'imap' subsystem, ID: [imap, default]
2015-08-17 16:29:32,742  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 16:29:33,029  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 16:29:33,089  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'locksSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:29:33,090  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'propertyValueSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:29:33,091  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 16:29:33,092  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 16:29:33,092  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'auditSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:29:33,094  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 16:29:33,094  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 16:29:33,095  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'contentSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:29:33,095  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 16:29:33,096  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 16:29:33,098  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'repoSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
Aug 17, 2015 4:29:33 PM org.apache.catalina.core.ApplicationContext log
INFO: Shutting down log4j
Aug 17, 2015 4:29:33 PM org.apache.catalina.core.ApplicationContext log
INFO: Destroying Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 4:29:33 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
Aug 17, 2015 4:29:33 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
Aug 17, 2015 4:30:04 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:30:04 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:30:04 PM org.apache.coyote.AbstractProtocol stop
INFO: Stopping ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:30:04 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:30:04 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:30:04 PM org.apache.coyote.AbstractProtocol destroy
INFO: Destroying ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:30:19 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /Users/vthakur/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
Aug 17, 2015 4:30:19 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:30:19 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:30:19 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:30:19 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 496 ms
Aug 17, 2015 4:30:19 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 17, 2015 4:30:19 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 17, 2015 4:30:19 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 17, 2015 4:30:19 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 17, 2015 4:30:22 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-17 16:30:24,539  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-17 16:30:24,539  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-17 16:30:24,615  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
Aug 17, 2015 4:30:24 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deployment of configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml has finished in 5,077 ms
Aug 17, 2015 4:30:24 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 17, 2015 4:30:24 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war has finished in 92 ms
Aug 17, 2015 4:30:24 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
2015-08-17 16:30:24,844  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 228 ms
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 17, 2015 4:30:29 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 4:30:29 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 16:30:31,884  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbcSmiley Tongueostgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-17 16:30:32,101  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-17 16:30:36,182  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 16:30:36,204  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-17 16:30:36,213  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-17 16:30:41,814  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-17 16:30:41,816  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-17 16:30:43,454  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 16:30:43,474  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-17 16:30:43,516  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbcSmiley Tongueostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-17 16:30:43,517  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-17 16:30:44,825  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
2015-08-17 16:30:45,472  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 16:30:45,573  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-17 16:30:46,068  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-17 16:30:46,077  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 16:30:46,158  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-17 16:30:46,158  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 16:30:46,202  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-17 16:30:46,317  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-17 16:30:46,317  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 4:30:46 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 17, 2015 4:30:46 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 4:30:46 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice 3.6 command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 4:30:46 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 17, 2015 4:30:46 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: starting process with acceptString 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1' and profileDir '/Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100'
Aug 17, 2015 4:30:46 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 17, 2015 4:30:48 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-17 16:30:48,221  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-17 16:30:48,224  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-17 16:30:48,228  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /Applications/alfresco-5.0.1.5/alf_data
2015-08-17 16:30:48,228  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 16:30:48,443  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-17 16:30:48,447  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-17 16:30:48,650  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2015-08-17 16:30:48,670  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-17 16:30:48,689  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-17 16:30:48,692  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 16:30:48,965  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-17 16:30:48,976  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
2015-08-17 16:30:48,982  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-17 16:30:48,982  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-17 16:30:49,000  ERROR [org.alfresco.fileserver] [CIFS Server] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
2015-08-17 16:30:49,004  ERROR [org.alfresco.fileserver] [CIFS Server] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
   at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
   at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
   at java.lang.Thread.run(Thread.java:745)
2015-08-17 16:30:49,063  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-17 16:30:49,063  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-17 16:30:49,114  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-17 16:30:49,115  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-17 16:30:49,156  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-17 16:30:49,156  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 16:30:49,197  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-17 16:30:49,219  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 16:30:49,309  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-17 16:30:49,341  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-17 16:30:49,358  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Wed Sep 16 00:00:00 IST 2015 (30 days remaining).
2015-08-17 16:30:49,358  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-17 16:30:49,358  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Enterprise). Current version: 5.0.1 (.5 r108957-b87) schema 8,022. Originally installed version: 5.0.1 (.5 r108957-b87) schema 8,022.
2015-08-17 16:30:49,367  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 16:30:49,529  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-17 16:30:49,530  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-17 16:30:49,542  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-17 16:30:50,317  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 16:30:50,382  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-17 16:30:52,705  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:30:52,706  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:30:52,706  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:30:54,008  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:30:54,009  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:30:54,009  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:30:54,010  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3599.808ms)
2015-08-17 16:30:54,025  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:30:54,026  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 16:30:55,111  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:30:55,111  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:30:55,112  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:30:55,154  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 16:30:55,154  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 16:30:55,154  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:30:55,226  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 16:30:55,226  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 16:30:55,226  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:30:55,227  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1161.2935ms)
2015-08-17 16:30:55,255  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 16:30:55,255  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 16:30:55,255  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 4:30:55 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 17, 2015 4:30:57 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 17, 2015 4:30:57 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war has finished in 33,054 ms
Aug 17, 2015 4:30:57 PM org.apache.catalina.core.StandardContext setPath
WARNING: A context path must either be an empty string or start with a '/' and do not end with a '/'. The path [/] does not meet these criteria and has been changed to []
Aug 17, 2015 4:30:57 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 17, 2015 4:30:57 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 17, 2015 4:30:57 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war has finished in 62 ms
Aug 17, 2015 4:30:57 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 17, 2015 4:30:59 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 4:30:59 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 16:31:02,273  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:31:02,277  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 16:31:02,279  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:31:02,282  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 16:31:03,009  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-17 16:31:03,009  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-17 16:31:03,009  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:31:03,046  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 764.57184ms)
2015-08-17 16:31:03,062  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:31:03,063  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 17, 2015 4:31:03 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 17, 2015 4:31:03 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 4:31:03 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war has finished in 5,371 ms
Aug 17, 2015 4:31:03 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 17, 2015 4:31:03 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager has finished in 49 ms
Aug 17, 2015 4:31:03 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 17, 2015 4:31:03 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager has finished in 34 ms
Aug 17, 2015 4:31:03 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:31:03 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:31:03 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:31:03 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 43790 ms
2015-08-17 16:32:36,276  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:32:36,276  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:32:36,276  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:32:36,277  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-1] Initialised Repository Web Script Container (in 1338.8623ms)
2015-08-17 16:32:37,437  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:32:37,438  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:32:37,438  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:32:44,115  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-4] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:32:44,116  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-4] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:32:44,116  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-4] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:32:44,117  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-4] Initialised Repository Web Script Container (in 1201.9731ms)
2015-08-17 16:32:45,281  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:32:45,281  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:32:45,281  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 4:38:13 PM org.apache.catalina.core.StandardServer await
INFO: A valid shutdown command was received via the shutdown port. Stopping the Server instance.
Aug 17, 2015 4:38:13 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:38:13 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:38:13 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:38:13 PM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
Aug 17, 2015 4:38:13 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate destroy
INFO: WSSERVLET15: JAX-WS servlet destroyed
Aug 17, 2015 4:38:13 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextDestroyed
INFO: WSSERVLET13: JAX-WS context listener destroyed
Aug 17, 2015 4:38:13 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
2015-08-17 16:38:13,921  INFO  [cluster.core.ClusteringBootstrap] [localhost-startStop-2] Clustering has shutdown.
2015-08-17 16:38:13,947  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 16:38:13,949  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 16:38:13,957  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Replication' subsystem, ID: [Replication, default]
2015-08-17 16:38:13,957  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Replication' subsystem, ID: [Replication, default]
2015-08-17 16:38:13,970  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 16:38:13,971  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 16:38:13,971  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, inbound]
2015-08-17 16:38:13,972  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, inbound]
2015-08-17 16:38:13,972  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 16:38:13,976  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 16:38:13,977  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 4:38:13 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopping
Aug 17, 2015 4:38:13 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 17, 2015 4:38:14 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 17, 2015 4:38:14 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager stop
INFO: stopped
2015-08-17 16:38:14,252  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
2015-08-17 16:38:14,267  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 16:38:14,267  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 16:38:14,268  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'solrSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:38:14,268  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'activitiesSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:38:14,269  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 16:38:14,269  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 16:38:14,269  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 16:38:14,270  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 16:38:14,280  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 16:38:14,281  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 16:38:14,281  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'email' subsystem, ID: [email, outbound]
2015-08-17 16:38:14,281  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'email' subsystem, ID: [email, outbound]
2015-08-17 16:38:14,282  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'imap' subsystem, ID: [imap, default]
2015-08-17 16:38:14,283  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'imap' subsystem, ID: [imap, default]
2015-08-17 16:38:14,737  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 16:38:15,037  ERROR [solr.tracker.AbstractTracker] [SolrTrackerScheduler_Worker-1] Tracking failed
org.alfresco.error.AlfrescoRuntimeException: 07170001 api/solr/aclchangesets return status:503
   at org.alfresco.solr.client.SOLRAPIClient.getAclChangeSets(SOLRAPIClient.java:159)
   at org.alfresco.solr.tracker.AclTracker.checkRepoAndIndexConsistency(AclTracker.java:347)
   at org.alfresco.solr.tracker.AclTracker.trackRepository(AclTracker.java:313)
   at org.alfresco.solr.tracker.AclTracker.doTrack(AclTracker.java:104)
   at org.alfresco.solr.tracker.AbstractTracker.track(AbstractTracker.java:152)
   at org.alfresco.solr.tracker.TrackerJob.execute(TrackerJob.java:47)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
   at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
2015-08-17 16:38:15,040  ERROR [solr.tracker.AbstractTracker] [SolrTrackerScheduler_Worker-3] Tracking failed
org.alfresco.error.AlfrescoRuntimeException: 07170000 api/solr/aclchangesets return status:503
   at org.alfresco.solr.client.SOLRAPIClient.getAclChangeSets(SOLRAPIClient.java:159)
   at org.alfresco.solr.tracker.AclTracker.checkRepoAndIndexConsistency(AclTracker.java:347)
   at org.alfresco.solr.tracker.AclTracker.trackRepository(AclTracker.java:313)
   at org.alfresco.solr.tracker.AclTracker.doTrack(AclTracker.java:104)
   at org.alfresco.solr.tracker.AbstractTracker.track(AbstractTracker.java:152)
   at org.alfresco.solr.tracker.TrackerJob.execute(TrackerJob.java:47)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
   at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
2015-08-17 16:38:15,053  ERROR [solr.tracker.AbstractTracker] [SolrTrackerScheduler_Worker-3] Tracking failed
org.alfresco.error.AlfrescoRuntimeException: 07170002 GetModelsDiff return status is 503
   at org.alfresco.solr.client.SOLRAPIClient.getModelsDiff(SOLRAPIClient.java:1091)
   at org.alfresco.solr.tracker.ModelTracker.trackModelsImpl(ModelTracker.java:245)
   at org.alfresco.solr.tracker.ModelTracker.trackModels(ModelTracker.java:217)
   at org.alfresco.solr.tracker.ModelTracker.doTrack(ModelTracker.java:167)
   at org.alfresco.solr.tracker.AbstractTracker.track(AbstractTracker.java:152)
   at org.alfresco.solr.tracker.TrackerJob.execute(TrackerJob.java:47)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
   at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
2015-08-17 16:38:15,206  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 16:38:15,268  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'locksSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:38:15,269  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'propertyValueSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:38:15,270  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 16:38:15,271  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 16:38:15,271  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'auditSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:38:15,272  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 16:38:15,273  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 16:38:15,273  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'contentSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
2015-08-17 16:38:15,274  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopping 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 16:38:15,275  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-2] Stopped 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 16:38:15,277  WARN  [factory.support.DisposableBeanAdapter] [localhost-startStop-2] Invocation of destroy method 'close' failed on bean with name 'repoSqlSessionTemplate': java.lang.UnsupportedOperationException: Manual close is not allowed over a Spring managed SqlSession
Aug 17, 2015 4:38:15 PM org.apache.catalina.core.ApplicationContext log
INFO: Shutting down log4j
Aug 17, 2015 4:38:15 PM org.apache.catalina.core.ApplicationContext log
INFO: Destroying Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 4:38:15 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: destroy called
Aug 17, 2015 4:38:15 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
Aug 17, 2015 4:39:33 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
INFO: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /Users/vthakur/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
Aug 17, 2015 4:39:34 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:39:34 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:39:34 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:39:34 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 469 ms
Aug 17, 2015 4:39:34 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 17, 2015 4:39:34 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 17, 2015 4:39:34 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 17, 2015 4:39:34 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 17, 2015 4:39:37 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-17 16:39:39,287  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-17 16:39:39,288  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-17 16:39:39,382  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
Aug 17, 2015 4:39:39 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deployment of configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml has finished in 5,144 ms
Aug 17, 2015 4:39:39 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 17, 2015 4:39:39 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war has finished in 89 ms
Aug 17, 2015 4:39:39 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
2015-08-17 16:39:39,655  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 272 ms
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 17, 2015 4:39:44 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 4:39:44 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 16:39:46,799  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbcSmiley Tongueostgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-17 16:39:46,919  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-17 16:39:50,820  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-17 16:39:50,841  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-17 16:39:50,850  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-17 16:39:55,829  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-17 16:39:55,831  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-17 16:39:57,313  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-17 16:39:57,332  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-17 16:39:57,378  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbcSmiley Tongueostgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-17 16:39:57,378  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-17 16:39:58,632  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] No changes were made to the schema.
2015-08-17 16:39:59,237  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-17 16:39:59,353  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-17 16:39:59,881  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-17 16:39:59,890  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-17 16:39:59,974  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-17 16:39:59,974  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-17 16:40:00,020  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-17 16:40:00,133  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-17 16:40:00,133  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 17, 2015 4:40:00 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 17, 2015 4:40:00 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 4:40:00 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Using GNU based LibreOffice 3.6 command on Mac: [/Applications/alfresco-5.0.1.5/libreoffice.app/Contents/MacOS/soffice, –accept=socket,host=127.0.0.1,port=8100;urp;, -env:UserInstallation=file:///Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100, –headless, –nocrashreport, –nodefault, –nofirststartwizard, –nolockcheck, –nologo, –norestore]
Aug 17, 2015 4:40:00 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 17, 2015 4:40:00 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: starting process with acceptString 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1' and profileDir '/Applications/alfresco-5.0.1.5/tomcat/temp/.jodconverter_socket_host-127.0.0.1_port-8100'
Aug 17, 2015 4:40:00 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 17, 2015 4:40:01 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-17 16:40:01,780  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-17 16:40:01,783  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-17 16:40:01,787  INFO  [repo.admin.ConfigurationChecker] [localhost-startStop-1] The Alfresco root data directory ('dir.root') is: /Applications/alfresco-5.0.1.5/alf_data
2015-08-17 16:40:01,787  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-17 16:40:01,979  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-17 16:40:01,984  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-17 16:40:02,211  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] No patches were required.
2015-08-17 16:40:02,227  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-17 16:40:02,247  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Starting module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-17 16:40:02,252  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-17 16:40:02,526  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-17 16:40:02,537  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS, Unable to get local domain/workgroup name, using default of WORKGROUP. This may be due to firewall settings or incorrect <broadcast> setting)
2015-08-17 16:40:02,543  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-17 16:40:02,543  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-17 16:40:02,560  ERROR [org.alfresco.fileserver] [CIFS Server] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
2015-08-17 16:40:02,565  ERROR [org.alfresco.fileserver] [CIFS Server] Error from JLAN
org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
   at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
   at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:479)
   at java.lang.Thread.run(Thread.java:745)
2015-08-17 16:40:02,615  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-17 16:40:02,615  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-17 16:40:02,664  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-17 16:40:02,665  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-17 16:40:02,703  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-17 16:40:02,704  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-17 16:40:02,721  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-17 16:40:02,738  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-17 16:40:02,864  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-17 16:40:02,904  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-17 16:40:02,930  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Wed Sep 16 00:00:00 IST 2015 (30 days remaining).
2015-08-17 16:40:02,930  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-17 16:40:02,930  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco started (Enterprise). Current version: 5.0.1 (.5 r108957-b87) schema 8,022. Originally installed version: 5.0.1 (.5 r108957-b87) schema 8,022.
2015-08-17 16:40:02,946  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-17 16:40:03,128  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-17 16:40:03,128  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-17 16:40:03,138  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-17 16:40:03,892  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-17 16:40:03,958  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-17 16:40:06,327  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:40:06,327  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:40:06,327  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:40:07,685  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:40:07,685  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:40:07,685  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:40:07,689  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3701.9739ms)
2015-08-17 16:40:07,704  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:40:07,706  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 16:40:08,926  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:40:08,927  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:40:08,927  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:40:08,972  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 16:40:08,972  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 16:40:08,972  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:40:09,005  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 16:40:09,005  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 16:40:09,005  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:40:09,007  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1257.5306ms)
2015-08-17 16:40:09,043  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-17 16:40:09,043  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-17 16:40:09,043  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 17, 2015 4:40:09 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 17, 2015 4:40:11 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 17, 2015 4:40:11 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war has finished in 32,073 ms
Aug 17, 2015 4:40:11 PM org.apache.catalina.core.StandardContext setPath
WARNING: A context path must either be an empty string or start with a '/' and do not end with a '/'. The path [/] does not meet these criteria and has been changed to []
Aug 17, 2015 4:40:11 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 17, 2015 4:40:11 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 17, 2015 4:40:11 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war has finished in 51 ms
Aug 17, 2015 4:40:11 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 17, 2015 4:40:12 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 17, 2015 4:40:12 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-17 16:40:16,543  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:40:16,546  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 16:40:16,547  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:40:16,547  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-17 16:40:17,430  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-17 16:40:17,430  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-17 16:40:17,430  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:40:17,477  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 929.5081ms)
2015-08-17 16:40:17,495  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-17 16:40:17,496  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 17, 2015 4:40:17 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 17, 2015 4:40:17 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 17, 2015 4:40:17 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deployment of web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war has finished in 6,030 ms
Aug 17, 2015 4:40:17 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 17, 2015 4:40:17 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager has finished in 42 ms
Aug 17, 2015 4:40:17 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 17, 2015 4:40:17 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deployment of web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager has finished in 34 ms
Aug 17, 2015 4:40:17 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 17, 2015 4:40:17 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 17, 2015 4:40:17 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 17, 2015 4:40:17 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 43516 ms
2015-08-17 16:40:25,454  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-3] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:40:25,455  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-3] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:40:25,455  INFO  [extensions.webscripts.DeclarativeRegistry] [http-bio-8080-exec-3] Registered 0 Schema Description Documents (+0 failed)
2015-08-17 16:40:25,456  INFO  [extensions.webscripts.AbstractRuntimeContainer] [http-bio-8080-exec-3] Initialised Repository Web Script Container (in 1369.0985ms)
2015-08-17 16:40:26,573  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-17 16:40:26,573  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-17 16:40:26,573  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
0 Kudos
Getting started

Tags

Find what you came for

We want to make your experience in Hyland Connect as valuable as possible, so we put together some helpful links.

Copyright © 2025 Khoros, LLC
li.common.scroll-to.top