AnsweredAssumed Answered

Unable to start Alfresco 5.0 on my local

Question asked by vivekthakur21 on Aug 12, 2015
Latest reply on Aug 13, 2015 by sujaypillai
I have installed Alfresco 5.0.1 on my mac machine and tried to deploy content model. Run three web-scripts successfully. Now unable to start my Alfresco. Cataline.out throws below content :
Aug 12, 2015 2:27:21 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 12, 2015 2:27:21 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8080"]
Aug 12, 2015 2:27:21 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["ajp-bio-8009"]
Aug 12, 2015 2:27:21 PM org.apache.coyote.AbstractProtocol init
INFO: Initializing ProtocolHandler ["http-bio-8443"]
Aug 12, 2015 2:27:21 PM org.apache.catalina.startup.Catalina load
INFO: Initialization processed in 480 ms
Aug 12, 2015 2:27:21 PM org.apache.catalina.core.StandardService startInternal
INFO: Starting service Catalina
Aug 12, 2015 2:27:21 PM org.apache.catalina.core.StandardEngine startInternal
INFO: Starting Servlet Engine: Apache Tomcat/7.0.59
Aug 12, 2015 2:27:21 PM org.apache.catalina.startup.HostConfig deployDescriptor
INFO: Deploying configuration descriptor /Applications/alfresco-5.0.1.5/tomcat/conf/Catalina/localhost/solr4.xml
Aug 12, 2015 2:27:21 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '0' did not find a matching property.
Aug 12, 2015 2:27:25 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
2015-08-12 14:27:27,055  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-1] Initializing SuggestComponent
2015-08-12 14:27:27,055  INFO  [solr.component.AsyncBuildSuggestComponent] [coreLoadExecutor-5-thread-2] Initializing SuggestComponent
2015-08-12 14:27:27,140  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loading suggester index for: shingleBasedSuggestions
2015-08-12 14:27:27,147  INFO  [solr.component.AsyncBuildSuggestComponent] [Suggestor-alfresco-1] Loaded suggester shingleBasedSuggestions, took 7 ms
Aug 12, 2015 2:27:27 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,542 ms
Aug 12, 2015 2:27:27 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/_vti_bin.war
Aug 12, 2015 2:27:27 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 77 ms
Aug 12, 2015 2:27:27 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/alfresco.war
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core_rt is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/core is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/core is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt_rt is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/fmt is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/fmt is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/functions is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/permittedTaglibs is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://jakarta.apache.org/taglibs/standard/scriptfree is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql_rt is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/sql is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/sql is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml_rt is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jstl/xml is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.startup.TaglibUriRule body
INFO: TLD skipped. URI: http://java.sun.com/jsp/jstl/xml is already defined
Aug 12, 2015 2:27:33 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 12, 2015 2:27:33 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-12 14:27:35,902  INFO  [alfresco.repo.admin] [localhost-startStop-1] Using database URL 'jdbc:postgresql://localhost:5432/alfresco' with user 'alfresco'.
2015-08-12 14:27:36,059  INFO  [alfresco.repo.admin] [localhost-startStop-1] Connected to database PostgreSQL version 9.3.6
2015-08-12 14:27:40,479  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
2015-08-12 14:27:40,505  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
2015-08-12 14:27:40,521  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Ignoring script patch (post-Hibernate): patch.db-V4.2-metadata-query-indexes
2015-08-12 14:27:47,153  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor Repository Template Processor for extension ftl
2015-08-12 14:27:47,157  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor Repository Script Processor for extension js
2015-08-12 14:27:49,303  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted]
2015-08-12 14:27:49,330  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ContentStore' subsystem, ID: [ContentStore, managed, unencrypted] complete
2015-08-12 14:27:49,384  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Connecting to database: jdbc:postgresql://localhost:5432/alfresco, UserName=alfresco, PostgreSQL Native Driver
2015-08-12 14:27:49,384  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
2015-08-12 14:27:49,469  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_-5402693380478589514.txt
2015-08-12 14:27:49,481  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_-7723793924530030414.txt
2015-08-12 14:27:49,491  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_-7593986915715494672.txt
2015-08-12 14:27:49,570  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_-7578754609102729041.xml.
2015-08-12 14:27:49,570  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_-6425599649686128507.xml.
2015-08-12 14:27:49,570  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_-8181931278251832471.xml.
2015-08-12 14:27:49,574  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3340475893574712883.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-RepoTables.sql).
2015-08-12 14:27:49,718  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-5215002105246103263.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-LockTables.sql).
2015-08-12 14:27:49,729  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-4673804065157828792.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ContentTables.sql).
2015-08-12 14:27:49,751  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-588282359637166167.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-PropertyValueTables.sql).
2015-08-12 14:27:49,799  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-5356694220105687825.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ContentUrlEncryptionTables.sql).
2015-08-12 14:27:49,811  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3586923808031096966.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-AuditTables.sql).
2015-08-12 14:27:49,832  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-771530908860423812.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ActivityTables.sql).
2015-08-12 14:27:49,851  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3547002283002888230.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-UsageTables.sql).
2015-08-12 14:27:49,857  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-7904584560163638915.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-SubscriptionTables.sql).
2015-08-12 14:27:49,861  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-2512126163301752322.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-TenantTables.sql).
2015-08-12 14:27:49,977  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-8547169155136106011.sql (Generated).
2015-08-12 14:27:50,177  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-7482433714383428015.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-Extra.sql).
2015-08-12 14:27:50,178  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3802613476385120534.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-FK-indexes.sql).
2015-08-12 14:27:50,256  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Executing database script /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-5076502093973670949.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-varinst-indexes.sql).
2015-08-12 14:27:50,260  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] Create scripts executed in 846 ms
2015-08-12 14:27:50,662  INFO  [domain.schema.SchemaBootstrap] [localhost-startStop-1] All executed statements:  /Applications/alfresco-5.0.1.5/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-All_Statements-1815861735813343097.sql.
2015-08-12 14:27:53,002  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-12 14:27:54,375  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-12 14:27:55,510  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-12 14:28:00,154  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_-9037993975873350880.xml.
2015-08-12 14:28:00,154  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_-3800558305989283155.xml.
2015-08-12 14:28:00,154  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_-1143054684985170276.xml.
2015-08-12 14:28:00,591  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Search' subsystem, ID: [Search, managed, solr4]
2015-08-12 14:28:00,829  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Search' subsystem, ID: [Search, managed, solr4] complete
2015-08-12 14:28:05,807  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
2015-08-12 14:28:05,915  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
2015-08-12 14:28:07,072  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Creating time limited trial license
2015-08-12 14:28:07,195  INFO  [repo.sync.SyncAdminServiceImpl] [localhost-startStop-1] There is no key for cloud sync, cloud sync turned off
2015-08-12 14:28:07,202  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
2015-08-12 14:28:07,277  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
2015-08-12 14:28:07,277  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
2015-08-12 14:28:07,317  WARN  [alfresco.util.AbstractTriggerBean] [localhost-startStop-1] Job openOfficeConnectionTesterTrigger is not enabled
2015-08-12 14:28:07,429  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
2015-08-12 14:28:07,429  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default]
Aug 12, 2015 2:28:07 PM org.artofsolving.jodconverter.office.ProcessPoolOfficeManager <init>
INFO: ProcessManager implementation is PureJavaProcessManager
Aug 12, 2015 2:28:07 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 12, 2015 2:28:07 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 12, 2015 2:28:07 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 12, 2015 2:28:07 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 12, 2015 2:28:07 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 12, 2015 2:28:09 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
2015-08-12 14:28:09,092  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'OOoJodconverter' subsystem, ID: [OOoJodconverter, default] complete
2015-08-12 14:28:09,102  WARN  [cluster.core.ClusteringBootstrap] [localhost-startStop-1] License does not permit clustering: clustering is disabled.
2015-08-12 14:28:09,110  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-12 14:28:09,122  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1] Checking for patches to apply …
2015-08-12 14:28:09,201  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-12 14:28:09,216  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-12 14:28:09,494  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]    Applying patch 'patch.siteLoadPatch.swsdp' (Loads a sample site into the repository.).
2015-08-12 14:28:11,883  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]    Applying patch 'patch.exampleJavaScript' (Loads sample Javascript file into datadictionary scripts folder).
2015-08-12 14:28:11,918  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V3.4-UsageTables
RESULT:
Script completed
=====================================
2015-08-12 14:28:11,919  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V4.0-TenantTables
RESULT:
Script completed
=====================================
2015-08-12 14:28:11,919  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V3.4-JBPM-varinst-indexes
RESULT:
Script completed
=====================================
2015-08-12 14:28:11,919  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.db-V5.0-ContentUrlEncryptionTables
RESULT:
Script completed
=====================================
2015-08-12 14:28:11,919  INFO  [admin.patch.PatchExecuter] [localhost-startStop-1]
=== Applied patch                 ===
ID: patch.siteLoadPatch.swsdp
RESULT:
Site swsdp imported.
=====================================
2015-08-12 14:28:11,919  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/81047699-0875-458d-a7b2-becc7d368b64)
=====================================
2015-08-12 14:28:11,936  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Found 1 module(s).
2015-08-12 14:28:11,953  INFO  [repo.module.ModuleServiceImpl] [localhost-startStop-1] Installing module 'org.alfresco.integrations.google.docs' version 3.0.0.
2015-08-12 14:28:11,968  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'fileServers' subsystem, ID: [fileServers, default]
2015-08-12 14:28:12,227  WARN  [org.alfresco.fileserver] [localhost-startStop-1] CIFS server name is longer than 15 characters, truncated to Administrators-
2015-08-12 14:28:12,238  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-12 14:28:12,244  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
2015-08-12 14:28:12,244  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'imap' subsystem, ID: [imap, default]
2015-08-12 14:28:12,261  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-12 14:28:12,266  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-12 14:28:12,316  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'imap' subsystem, ID: [imap, default] complete
2015-08-12 14:28:12,316  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, outbound]
2015-08-12 14:28:12,374  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, outbound] complete
2015-08-12 14:28:12,374  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'email' subsystem, ID: [email, inbound]
2015-08-12 14:28:12,418  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'email' subsystem, ID: [email, inbound] complete
2015-08-12 14:28:12,418  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
2015-08-12 14:28:12,436  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
2015-08-12 14:28:12,452  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
2015-08-12 14:28:12,524  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
2015-08-12 14:28:12,547  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco JVM - v1.8.0_31-b13; maximum heap size 8125.500MB
2015-08-12 14:28:12,557  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Alfresco license: Mode ENTERPRISE, NO CLUSTER granted to Trial User limited to 30 days expiring Fri Sep 11 00:00:00 IST 2015 (30 days remaining).
2015-08-12 14:28:12,557  INFO  [service.descriptor.DescriptorService] [localhost-startStop-1] Server Mode :UNKNOWN
2015-08-12 14:28:12,557  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-12 14:28:12,564  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
2015-08-12 14:28:12,725  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
2015-08-12 14:28:12,725  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'Replication' subsystem, ID: [Replication, default]
2015-08-12 14:28:12,736  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'Replication' subsystem, ID: [Replication, default] complete
2015-08-12 14:28:13,584  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Starting 'googledocs' subsystem, ID: [googledocs, drive]
2015-08-12 14:28:13,665  INFO  [management.subsystems.ChildApplicationContextFactory] [localhost-startStop-1] Startup of 'googledocs' subsystem, ID: [googledocs, drive] complete
2015-08-12 14:28:15,895  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-12 14:28:15,896  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-12 14:28:15,896  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-12 14:28:17,200  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-12 14:28:17,200  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 1 Package Description Documents (+0 failed)
2015-08-12 14:28:17,200  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-12 14:28:17,202  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Repository Web Script Container (in 3496.2773ms)
2015-08-12 14:28:17,215  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-12 14:28:17,217  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-12 14:28:18,377  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 497 Web Scripts (+0 failed), 649 URLs
2015-08-12 14:28:18,377  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 1 Package Description Documents (+0 failed)
2015-08-12 14:28:18,377  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-12 14:28:18,423  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-12 14:28:18,423  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-12 14:28:18,423  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
2015-08-12 14:28:18,525  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-12 14:28:18,525  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Package Description Documents (+0 failed)
2015-08-12 14:28:18,525  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-12 14:28:18,526  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Public Api Web Script Container (in 1260.0072ms)
2015-08-12 14:28:18,561  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 11 Web Scripts (+0 failed), 82 URLs
2015-08-12 14:28:18,562  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Package Description Documents (+0 failed)
2015-08-12 14:28:18,562  INFO  [extensions.webscripts.DeclarativeRegistry] [asynchronouslyRefreshedCacheThreadPool1] Registered 0 Schema Description Documents (+0 failed)
Aug 12, 2015 2:28:18 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextInitialized
INFO: WSSERVLET12: JAX-WS context listener initializing
Aug 12, 2015 2:28:20 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate <init>
INFO: WSSERVLET14: JAX-WS servlet initializing
Aug 12, 2015 2:28:21 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 53,930 ms
Aug 12, 2015 2:28:21 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 12, 2015 2:28:21 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/ROOT.war
Aug 12, 2015 2:28:21 PM org.apache.catalina.startup.SetContextPropertiesRule begin
WARNING: [SetContextPropertiesRule]{Context} Setting property 'debug' to '100' did not find a matching property.
Aug 12, 2015 2:28:21 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 12, 2015 2:28:21 PM org.apache.catalina.startup.HostConfig deployWAR
INFO: Deploying web application archive /Applications/alfresco-5.0.1.5/tomcat/webapps/share.war
Aug 12, 2015 2:28:24 PM org.apache.catalina.core.ApplicationContext log
INFO: No Spring WebApplicationInitializer types detected on classpath
Aug 12, 2015 2:28:24 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring root WebApplicationContext
2015-08-12 14:28:29,007  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-12 14:28:29,010  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-12 14:28:29,010  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-12 14:28:29,011  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
2015-08-12 14:28:29,892  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 369 Web Scripts (+0 failed), 383 URLs
2015-08-12 14:28:29,892  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 8 Package Description Documents (+0 failed)
2015-08-12 14:28:29,892  INFO  [extensions.webscripts.DeclarativeRegistry] [localhost-startStop-1] Registered 0 Schema Description Documents (+0 failed)
2015-08-12 14:28:29,945  INFO  [extensions.webscripts.AbstractRuntimeContainer] [localhost-startStop-1] Initialised Spring Surf Container Web Script Container (in 933.2055ms)
2015-08-12 14:28:29,967  INFO  [extensions.webscripts.TemplateProcessorRegistry] [localhost-startStop-1] Registered template processor freemarker for extension ftl
2015-08-12 14:28:29,967  INFO  [extensions.webscripts.ScriptProcessorRegistry] [localhost-startStop-1] Registered script processor javascript for extension js
Aug 12, 2015 2:28:30 PM org.apache.catalina.core.ApplicationContext log
INFO: org.tuckey.web.filters.urlrewrite.UrlRewriteFilter INFO: loaded (conf ok)
Aug 12, 2015 2:28:30 PM org.apache.catalina.core.ApplicationContext log
INFO: Initializing Spring FrameworkServlet 'Spring Surf Dispatcher Servlet'
Aug 12, 2015 2:28:30 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,906 ms
Aug 12, 2015 2:28:30 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/host-manager
Aug 12, 2015 2:28:30 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 55 ms
Aug 12, 2015 2:28:30 PM org.apache.catalina.startup.HostConfig deployDirectory
INFO: Deploying web application directory /Applications/alfresco-5.0.1.5/tomcat/webapps/manager
Aug 12, 2015 2:28:30 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 46 ms
Aug 12, 2015 2:28:30 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8080"]
Aug 12, 2015 2:28:30 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["ajp-bio-8009"]
Aug 12, 2015 2:28:30 PM org.apache.coyote.AbstractProtocol start
INFO: Starting ProtocolHandler ["http-bio-8443"]
Aug 12, 2015 2:28:30 PM org.apache.catalina.startup.Catalina start
INFO: Server startup in 68671 ms
2015-08-12 14:28:33,355  INFO  [web.site.EditionInterceptor] [http-bio-8080-exec-4] Successfully retrieved license information from Alfresco.
2015-08-12 14:29:00,064  INFO  [management.subsystems.ChildApplicationContextFactory] [http-bio-8443-exec-4] Starting 'Transformers' subsystem, ID: [Transformers, default]
2015-08-12 14:29:00,239  INFO  [management.subsystems.ChildApplicationContextFactory] [http-bio-8443-exec-4] Startup of 'Transformers' subsystem, ID: [Transformers, default] complete
2015-08-12 14:31:50,826  INFO  [web.scripts.ImapServerStatus] [http-bio-8080-exec-2] Successfully retrieved IMAP server status from Alfresco: disabled
2015-08-12 14:31:50,946  INFO  [web.scripts.SyncModeConfig] [http-bio-8080-exec-2] Successfully retrieved Sync Mode configuration from Alfresco: OFF
2015-08-12 14:31:59,488  INFO  [web.scripts.DictionaryQuery] [http-bio-8080-exec-6] Successfully retrieved Data Dictionary from Alfresco.
Aug 12, 2015 2:34:44 PM org.apache.catalina.core.StandardWrapperValve invoke
SEVERE: Servlet.service() for servlet [Spring Surf Dispatcher Servlet] in context with path [/share] threw exception [Could not resolve view with name 'site/test/dashboard' in servlet with name 'Spring Surf Dispatcher Servlet'] with root cause
javax.servlet.ServletException: Could not resolve view with name 'site/test/dashboard' in servlet with name 'Spring Surf Dispatcher Servlet'
   at org.springframework.web.servlet.DispatcherServlet.render(DispatcherServlet.java:1183)
   at org.springframework.web.servlet.DispatcherServlet.processDispatchResult(DispatcherServlet.java:986)
   at org.springframework.web.servlet.DispatcherServlet.doDispatch(DispatcherServlet.java:933)
   at org.springframework.web.servlet.DispatcherServlet.doService(DispatcherServlet.java:851)
   at org.springframework.web.servlet.FrameworkServlet.processRequest(FrameworkServlet.java:953)
   at org.springframework.web.servlet.FrameworkServlet.doGet(FrameworkServlet.java:844)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:620)
   at org.springframework.web.servlet.FrameworkServlet.service(FrameworkServlet.java:829)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.alfresco.web.site.servlet.SecurityHeadersFilter.doFilter(SecurityHeadersFilter.java:168)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.alfresco.web.site.servlet.CSRFFilter.doFilter(CSRFFilter.java:315)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.alfresco.web.site.servlet.SSOAuthenticationFilter.doFilter(SSOAuthenticationFilter.java:447)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.alfresco.web.site.servlet.MTAuthenticationFilter.doFilter(MTAuthenticationFilter.java:74)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
   at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
   at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:504)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:421)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1074)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:611)
   at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:314)
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
   at java.lang.Thread.run(Thread.java:745)

2015-08-12 14:34:44,235  ERROR [alfresco.web.site] [http-bio-8080-exec-2] javax.servlet.ServletException: Could not resolve view with name 'site/test/dashboard' in servlet with name 'Spring Surf Dispatcher Servlet'
2015-08-12 14:35:00,501  ERROR [extensions.webscripts.AbstractRuntime] [http-bio-8080-exec-6] Exception from executeScript - redirecting to status template error: 07120000 Script URL not specified
org.springframework.extensions.webscripts.WebScriptException: 07120000 Script URL not specified
   at org.springframework.extensions.webscripts.AbstractRuntime.executeScript(AbstractRuntime.java:122)
   at org.springframework.extensions.webscripts.servlet.WebScriptServlet.service(WebScriptServlet.java:132)
   at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:303)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.apache.tomcat.websocket.server.WsFilter.doFilter(WsFilter.java:52)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.alfresco.web.app.servlet.GlobalLocalizationFilter.doFilter(GlobalLocalizationFilter.java:61)
   at org.apache.catalina.core.ApplicationFilterChain.internalDoFilter(ApplicationFilterChain.java:241)
   at org.apache.catalina.core.ApplicationFilterChain.doFilter(ApplicationFilterChain.java:208)
   at org.apache.catalina.core.StandardWrapperValve.invoke(StandardWrapperValve.java:220)
   at org.apache.catalina.core.StandardContextValve.invoke(StandardContextValve.java:122)
   at org.apache.catalina.authenticator.AuthenticatorBase.invoke(AuthenticatorBase.java:504)
   at org.apache.catalina.core.StandardHostValve.invoke(StandardHostValve.java:170)
   at org.apache.catalina.valves.ErrorReportValve.invoke(ErrorReportValve.java:103)
   at org.apache.catalina.valves.AccessLogValve.invoke(AccessLogValve.java:950)
   at org.apache.catalina.core.StandardEngineValve.invoke(StandardEngineValve.java:116)
   at org.apache.catalina.connector.CoyoteAdapter.service(CoyoteAdapter.java:421)
   at org.apache.coyote.http11.AbstractHttp11Processor.process(AbstractHttp11Processor.java:1074)
   at org.apache.coyote.AbstractProtocol$AbstractConnectionHandler.process(AbstractProtocol.java:611)
   at org.apache.tomcat.util.net.JIoEndpoint$SocketProcessor.run(JIoEndpoint.java:316)
   at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61)
   at java.lang.Thread.run(Thread.java:745)
Aug 12, 2015 2:35:40 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 12, 2015 2:35:40 PM org.artofsolving.jodconverter.office.PooledOfficeManager$1 disconnected
WARNING: connection lost unexpectedly; attempting restart
Aug 12, 2015 2:35:40 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 12, 2015 2:35:40 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 12, 2015 2:35:40 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 12, 2015 2:35:40 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 12, 2015 2:35:40 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 12, 2015 2:35:40 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 12, 2015 2:35:41 PM org.artofsolving.jodconverter.office.OfficeConnection connect
INFO: connected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 12, 2015 2:35:47 PM org.artofsolving.jodconverter.office.OfficeConnection$1 disposing
INFO: disconnected: 'socket,host=127.0.0.1,port=8100,tcpNoDelay=1'
Aug 12, 2015 2:35:47 PM org.artofsolving.jodconverter.office.PooledOfficeManager$1 disconnected
WARNING: connection lost unexpectedly; attempting restart
Aug 12, 2015 2:35:48 PM org.artofsolving.jodconverter.office.ManagedOfficeProcess doEnsureProcessExited
INFO: process exited with code 0
Aug 12, 2015 2:35:48 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 12, 2015 2:35:48 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 12, 2015 2:35:48 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: Removing $DYLD_LIBRARY_PATH from the environment so that LibreOffice/OpenOffice will start on Mac.
Aug 12, 2015 2:35:48 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 12, 2015 2:35:48 PM org.artofsolving.jodconverter.office.OfficeProcess start
INFO: started process
Aug 12, 2015 2:35:49 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8080"]
Aug 12, 2015 2:35:49 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["ajp-bio-8009"]
Aug 12, 2015 2:35:49 PM org.apache.coyote.AbstractProtocol pause
INFO: Pausing ProtocolHandler ["http-bio-8443"]
Aug 12, 2015 2:35:49 PM org.apache.catalina.core.StandardService stopInternal
INFO: Stopping service Catalina
Aug 12, 2015 2:35:49 PM com.sun.xml.ws.transport.http.servlet.WSServletDelegate destroy
INFO: WSSERVLET15: JAX-WS servlet destroyed
Aug 12, 2015 2:35:49 PM com.sun.xml.ws.transport.http.servlet.WSServletContextListener contextDestroyed
INFO: WSSERVLET13: JAX-WS context listener destroyed
Aug 12, 2015 2:35:49 PM org.apache.catalina.core.ApplicationContext log
INFO: Closing Spring root WebApplicationContext
2015-08-12 14:35:53,017  ERROR [impl.jobexecutor.AcquireJobsRunnableImpl] [Thread-54] exception during job acquisition: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
org.springframework.transaction.CannotCreateTransactionException: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:597)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:372)
   at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:128)
   at org.activiti.spring.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:45)
   at org.activiti.engine.impl.interceptor.LogInterceptor.execute(LogInterceptor.java:31)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:40)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:35)
   at org.activiti.engine.impl.jobexecutor.AcquireJobsRunnableImpl.run(AcquireJobsRunnableImpl.java:54)
   at java.lang.Thread.run(Thread.java:745)
Caused by: org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:74)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:29)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:426)
   at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:144)
   at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:119)
   at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:57)
   at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1326)
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:556)
   … 8 more
Caused by: org.postgresql.util.PSQLException: Connection refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:215)
   at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:64)
   at org.postgresql.jdbc2.AbstractJdbc2Connection.<init>(AbstractJdbc2Connection.java:144)
   at org.postgresql.jdbc3.AbstractJdbc3Connection.<init>(AbstractJdbc3Connection.java:29)
   at org.postgresql.jdbc3g.AbstractJdbc3gConnection.<init>(AbstractJdbc3gConnection.java:21)
   at org.postgresql.jdbc4.AbstractJdbc4Connection.<init>(AbstractJdbc4Connection.java:31)
   at org.postgresql.jdbc4.Jdbc4Connection.<init>(Jdbc4Connection.java:24)
   at org.postgresql.Driver.makeConnection(Driver.java:410)
   at org.postgresql.Driver.connect(Driver.java:280)
   at org.apache.commons.dbcp.DriverConnectionFactory.createConnection(DriverConnectionFactory.java:38)
   at org.apache.commons.dbcp.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:582)
   at org.apache.commons.pool.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:1188)
   at org.apache.commons.dbcp.PoolingDataSource.getConnection(PoolingDataSource.java:106)
   at org.apache.commons.dbcp.BasicDataSource.getConnection(BasicDataSource.java:1044)
   at org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider.getConnection(LocalDataSourceConnectionProvider.java:83)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:423)
   … 13 more
Caused by: java.net.ConnectException: Connection refused
   at java.net.PlainSocketImpl.socketConnect(Native Method)
   at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
   at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
   at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
   at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   at java.net.Socket.connect(Socket.java:589)
   at org.postgresql.core.PGStream.<init>(PGStream.java:61)
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:109)
   … 28 more
2015-08-12 14:35:58,020  ERROR [impl.jobexecutor.AcquireJobsRunnableImpl] [Thread-54] exception during job acquisition: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
org.springframework.transaction.CannotCreateTransactionException: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:597)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:372)
   at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:128)
   at org.activiti.spring.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:45)
   at org.activiti.engine.impl.interceptor.LogInterceptor.execute(LogInterceptor.java:31)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:40)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:35)
   at org.activiti.engine.impl.jobexecutor.AcquireJobsRunnableImpl.run(AcquireJobsRunnableImpl.java:54)
   at java.lang.Thread.run(Thread.java:745)
Caused by: org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:74)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:29)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:426)
   at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:144)
   at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:119)
   at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:57)
   at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1326)
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:556)
   … 8 more
Caused by: org.postgresql.util.PSQLException: Connection refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:215)
   at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:64)
   at org.postgresql.jdbc2.AbstractJdbc2Connection.<init>(AbstractJdbc2Connection.java:144)
   at org.postgresql.jdbc3.AbstractJdbc3Connection.<init>(AbstractJdbc3Connection.java:29)
   at org.postgresql.jdbc3g.AbstractJdbc3gConnection.<init>(AbstractJdbc3gConnection.java:21)
   at org.postgresql.jdbc4.AbstractJdbc4Connection.<init>(AbstractJdbc4Connection.java:31)
   at org.postgresql.jdbc4.Jdbc4Connection.<init>(Jdbc4Connection.java:24)
   at org.postgresql.Driver.makeConnection(Driver.java:410)
   at org.postgresql.Driver.connect(Driver.java:280)
   at org.apache.commons.dbcp.DriverConnectionFactory.createConnection(DriverConnectionFactory.java:38)
   at org.apache.commons.dbcp.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:582)
   at org.apache.commons.pool.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:1188)
   at org.apache.commons.dbcp.PoolingDataSource.getConnection(PoolingDataSource.java:106)
   at org.apache.commons.dbcp.BasicDataSource.getConnection(BasicDataSource.java:1044)
   at org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider.getConnection(LocalDataSourceConnectionProvider.java:83)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:423)
   … 13 more
Caused by: java.net.ConnectException: Connection refused
   at java.net.PlainSocketImpl.socketConnect(Native Method)
   at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
   at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
   at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
   at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   at java.net.Socket.connect(Socket.java:589)
   at org.postgresql.core.PGStream.<init>(PGStream.java:61)
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:109)
   … 28 more
2015-08-12 14:36:00,006  ERROR [quartz.core.JobRunShell] [DefaultScheduler_Worker-5] Job DEFAULT.feedGeneratorJobDetail threw an unhandled Exception:
org.alfresco.repo.security.permissions.AccessDeniedException: 07120029 Access Denied.  The system is currently in read-only mode.
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:394)
   at org.alfresco.repo.activities.feed.AbstractFeedGenerator.execute(AbstractFeedGenerator.java:176)
   at org.alfresco.repo.activities.feed.FeedGeneratorJob.execute(FeedGeneratorJob.java:50)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
   at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
2015-08-12 14:36:00,007  ERROR [quartz.core.ErrorLogger] [DefaultScheduler_Worker-5] Job (DEFAULT.feedGeneratorJobDetail threw an exception.
org.quartz.SchedulerException: Job threw an unhandled exception. [See nested exception: org.alfresco.repo.security.permissions.AccessDeniedException: 07120029 Access Denied.  The system is currently in read-only mode.]
   at org.quartz.core.JobRunShell.run(JobRunShell.java:227)
   at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:563)
Caused by: org.alfresco.repo.security.permissions.AccessDeniedException: 07120029 Access Denied.  The system is currently in read-only mode.
   at org.alfresco.repo.transaction.RetryingTransactionHelper.doInTransaction(RetryingTransactionHelper.java:394)
   at org.alfresco.repo.activities.feed.AbstractFeedGenerator.execute(AbstractFeedGenerator.java:176)
   at org.alfresco.repo.activities.feed.FeedGeneratorJob.execute(FeedGeneratorJob.java:50)
   at org.quartz.core.JobRunShell.run(JobRunShell.java:216)
   … 1 more
2015-08-12 14:36:00,030  ERROR [solr.tracker.AbstractTracker] [SolrTrackerScheduler_Worker-3] Tracking failed
org.alfresco.error.AlfrescoRuntimeException: 07120001 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-12 14:36:00,035  ERROR [solr.tracker.AbstractTracker] [SolrTrackerScheduler_Worker-2] Tracking failed
org.alfresco.error.AlfrescoRuntimeException: 07120000 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-12 14:36:00,053  ERROR [solr.tracker.AbstractTracker] [SolrTrackerScheduler_Worker-2] Tracking failed
org.alfresco.error.AlfrescoRuntimeException: 07120002 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-12 14:36:03,028  ERROR [impl.jobexecutor.AcquireJobsRunnableImpl] [Thread-54] exception during job acquisition: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
org.springframework.transaction.CannotCreateTransactionException: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:597)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:372)
   at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:128)
   at org.activiti.spring.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:45)
   at org.activiti.engine.impl.interceptor.LogInterceptor.execute(LogInterceptor.java:31)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:40)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:35)
   at org.activiti.engine.impl.jobexecutor.AcquireJobsRunnableImpl.run(AcquireJobsRunnableImpl.java:54)
   at java.lang.Thread.run(Thread.java:745)
Caused by: org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:74)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:29)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:426)
   at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:144)
   at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:119)
   at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:57)
   at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1326)
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:556)
   … 8 more
Caused by: org.postgresql.util.PSQLException: Connection refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:215)
   at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:64)
   at org.postgresql.jdbc2.AbstractJdbc2Connection.<init>(AbstractJdbc2Connection.java:144)
   at org.postgresql.jdbc3.AbstractJdbc3Connection.<init>(AbstractJdbc3Connection.java:29)
   at org.postgresql.jdbc3g.AbstractJdbc3gConnection.<init>(AbstractJdbc3gConnection.java:21)
   at org.postgresql.jdbc4.AbstractJdbc4Connection.<init>(AbstractJdbc4Connection.java:31)
   at org.postgresql.jdbc4.Jdbc4Connection.<init>(Jdbc4Connection.java:24)
   at org.postgresql.Driver.makeConnection(Driver.java:410)
   at org.postgresql.Driver.connect(Driver.java:280)
   at org.apache.commons.dbcp.DriverConnectionFactory.createConnection(DriverConnectionFactory.java:38)
   at org.apache.commons.dbcp.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:582)
   at org.apache.commons.pool.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:1188)
   at org.apache.commons.dbcp.PoolingDataSource.getConnection(PoolingDataSource.java:106)
   at org.apache.commons.dbcp.BasicDataSource.getConnection(BasicDataSource.java:1044)
   at org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider.getConnection(LocalDataSourceConnectionProvider.java:83)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:423)
   … 13 more
Caused by: java.net.ConnectException: Connection refused
   at java.net.PlainSocketImpl.socketConnect(Native Method)
   at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
   at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
   at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
   at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   at java.net.Socket.connect(Socket.java:589)
   at org.postgresql.core.PGStream.<init>(PGStream.java:61)
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:109)
   … 28 more
2015-08-12 14:36:08,040  ERROR [impl.jobexecutor.AcquireJobsRunnableImpl] [Thread-54] exception during job acquisition: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
org.springframework.transaction.CannotCreateTransactionException: Could not open Hibernate Session for transaction; nested exception is org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:597)
   at org.springframework.transaction.support.AbstractPlatformTransactionManager.getTransaction(AbstractPlatformTransactionManager.java:372)
   at org.springframework.transaction.support.TransactionTemplate.execute(TransactionTemplate.java:128)
   at org.activiti.spring.SpringTransactionInterceptor.execute(SpringTransactionInterceptor.java:45)
   at org.activiti.engine.impl.interceptor.LogInterceptor.execute(LogInterceptor.java:31)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:40)
   at org.activiti.engine.impl.cfg.CommandExecutorImpl.execute(CommandExecutorImpl.java:35)
   at org.activiti.engine.impl.jobexecutor.AcquireJobsRunnableImpl.run(AcquireJobsRunnableImpl.java:54)
   at java.lang.Thread.run(Thread.java:745)
Caused by: org.hibernate.exception.JDBCConnectionException: Cannot open connection
   at org.hibernate.exception.SQLStateConverter.convert(SQLStateConverter.java:74)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:43)
   at org.hibernate.exception.JDBCExceptionHelper.convert(JDBCExceptionHelper.java:29)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:426)
   at org.hibernate.jdbc.ConnectionManager.getConnection(ConnectionManager.java:144)
   at org.hibernate.jdbc.JDBCContext.connection(JDBCContext.java:119)
   at org.hibernate.transaction.JDBCTransaction.begin(JDBCTransaction.java:57)
   at org.hibernate.impl.SessionImpl.beginTransaction(SessionImpl.java:1326)
   at org.springframework.orm.hibernate3.HibernateTransactionManager.doBegin(HibernateTransactionManager.java:556)
   … 8 more
Caused by: org.postgresql.util.PSQLException: Connection refused. Check that the hostname and port are correct and that the postmaster is accepting TCP/IP connections.
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:215)
   at org.postgresql.core.ConnectionFactory.openConnection(ConnectionFactory.java:64)
   at org.postgresql.jdbc2.AbstractJdbc2Connection.<init>(AbstractJdbc2Connection.java:144)
   at org.postgresql.jdbc3.AbstractJdbc3Connection.<init>(AbstractJdbc3Connection.java:29)
   at org.postgresql.jdbc3g.AbstractJdbc3gConnection.<init>(AbstractJdbc3gConnection.java:21)
   at org.postgresql.jdbc4.AbstractJdbc4Connection.<init>(AbstractJdbc4Connection.java:31)
   at org.postgresql.jdbc4.Jdbc4Connection.<init>(Jdbc4Connection.java:24)
   at org.postgresql.Driver.makeConnection(Driver.java:410)
   at org.postgresql.Driver.connect(Driver.java:280)
   at org.apache.commons.dbcp.DriverConnectionFactory.createConnection(DriverConnectionFactory.java:38)
   at org.apache.commons.dbcp.PoolableConnectionFactory.makeObject(PoolableConnectionFactory.java:582)
   at org.apache.commons.pool.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:1188)
   at org.apache.commons.dbcp.PoolingDataSource.getConnection(PoolingDataSource.java:106)
   at org.apache.commons.dbcp.BasicDataSource.getConnection(BasicDataSource.java:1044)
   at org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider.getConnection(LocalDataSourceConnectionProvider.java:83)
   at org.hibernate.jdbc.ConnectionManager.openConnection(ConnectionManager.java:423)
   … 13 more
Caused by: java.net.ConnectException: Connection refused
   at java.net.PlainSocketImpl.socketConnect(Native Method)
   at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:345)
   at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
   at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
   at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   at java.net.Socket.connect(Socket.java:589)
   at org.postgresql.core.PGStream.<init>(PGStream.java:61)
   at org.postgresql.core.v3.ConnectionFactoryImpl.openConnectionImpl(ConnectionFactoryImpl.java:109)
   … 28 more

Outcomes