Tomcat se bloquea y no arranca Alfresco 4.0b

[albertomi]

Hola,

estoy intentando instalar Alfresco 4.0b en un equipo con Linux.
El servidor de aplicaciones es Tomcat y el servidor de base de datos es PostgreSQL

Inicio Tomcat y se me queda parado el log en esta línea:

INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js‍

Os pongo el fichero de log:

22:02:09,903 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
22:02:09,970 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
22:02:09,971 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
22:02:09,975 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
22:02:12,625 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 314 Web Scripts (+0 failed), 324 URLs
22:02:12,625 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 8 Package Description Documents (+0 failed) 
22:02:12,625 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 0 Schema Description Documents (+0 failed) 
22:02:13,100 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Spring Surf Container Web Script Container (in 3120.3757ms)
22:02:13,107 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
22:02:13,112 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js
22:02:32,720 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'sysAdmin' subsystem, ID: [sysAdmin, default]
22:02:32,858 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'sysAdmin' subsystem, ID: [sysAdmin, default] complete
22:02:42,912 WARN  [org.alfresco.util.AbstractTriggerBean] Job ehCacheTracerJob is not active/enabled
22:02:47,072 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor Repository Template Processor for extension ftl
22:02:47,075 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor Repository Script Processor for extension js
22:02:55,637 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.PostgreSQLDialect.
22:02:56,622 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-748052619670324102.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-RepoTables.sql).
22:03:01,166 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3346971998608863735.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-LockTables.sql).
22:03:01,820 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-921137879932131202.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ContentTables.sql).
22:03:03,099 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-2878423222434799596.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-PropertyValueTables.sql).
22:03:04,646 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-7892937986063204992.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-AuditTables.sql).
22:03:05,496 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3349138105077731424.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-AvmTables.sql).
22:03:08,078 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-2882641989790269631.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-ActivityTables.sql).
22:03:08,878 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-4638917348503829222.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-UsageTables.sql).
22:03:09,022 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-388744417829205663.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoCreate-SubscriptionTables.sql).
22:03:09,543 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-2221522478103429087.sql (Generated).
22:03:14,002 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-4500955377973354488.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-Extra.sql).
22:03:14,024 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-Update-3414271196554271169.sql (Copied from classpath:alfresco/dbscripts/create/org.hibernate.dialect.PostgreSQLDialect/AlfrescoPostCreate-JBPM-FK-indexes.sql).
22:03:24,396 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] All executed statements:  /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-All_Statements-5714096760321098632.sql.
22:03:32,001 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Normalized schema dumped to file /opt/alfresco/tomcat/temp/Alfresco/AlfrescoSchema-PostgreSQLDialect-32443911996381025.xml.
22:03:32,317 WARN  [org.alfresco.repo.dictionary.DictionaryRepositoryBootstrap] StoreRef 'workspace://SpacesStore' does not exist
22:03:32,430 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Search' subsystem, ID: [Search, managed, solr]
22:03:32,618 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Search' subsystem, ID: [Search, managed, solr] complete
22:03:46,166 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [thirdparty, default]
22:03:46,335 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [thirdparty, default] complete
22:03:46,335 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'OOoDirect' subsystem, ID: [OOoDirect, default]
22:03:46,587 ERROR [org.alfresco.util.exec.RuntimeExecBootstrapBean] Bootstrap command failed: 
Execution result: 
   os:         Linux
   command:    [/program/soffice.bin, -accept=socket,host=127.0.0.1,port=8100;urp;StarOffice.ServiceManager, -env:UserInstallation=file:///opt/alfresco/alf_data/oouser, -nologo, -headless, -nofirststartwizard, -nocrashrep, -norestore]
   succeeded:  false
   exit code:  2
   out:        
   err:        Cannot run program "/program/soffice.bin": java.io.IOException: error=2, No such file or directory
22:03:46,668 WARN  [org.alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
22:03:46,674 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'OOoDirect' subsystem, ID: [OOoDirect, default] complete
22:03:46,754 INFO  [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: /opt/alfresco/alf_data
22:03:46,763 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] Checking for patches to apply …
22:03:49,092 WARN  [org.alfresco.repo.admin.patch.PatchExecuter] Patch description is not available: Patch[ id=patch.migrateAttrDelete, description=patch.migrateAttrDelete.description, fixesFromSchema=0, fixesToSchema=4106, targetSchema=4107]
22:03:49,310 WARN  [org.alfresco.repo.admin.patch.PatchExecuter] Patch description is not available: Patch[ id=patch.activitiesEmailTemplate, description=patch.activitiesEmailTemplate.description, fixesFromSchema=0, fixesToSchema=5005, targetSchema=5006]
22:03:49,510 WARN  [org.alfresco.repo.admin.patch.PatchExecuter] Patch description is not available: Patch[ id=patch.publishing.root, description=patch.publishing.root.description, fixesFromSchema=0, fixesToSchema=5013, targetSchema=5014]
22:03:49,591 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.siteLoadPatch.swsdp' (Loads a sample site into the repository.).
22:03:49,658 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1]
22:03:49,906 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [Authentication, managed, alfrescoNtlm1] complete
22:03:56,953 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.exampleJavaScript' (Loads sample Javascript file into datadictionary scripts folder).
22:03:57,040 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.4-UsageTables
RESULT: 
Script completed
=====================================
22:03:57,041 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.0-ActivityTables
RESULT: 
Script completed
=====================================
22:03:57,041 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-LockTables
RESULT: 
Script completed
=====================================
22:03:57,041 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-ContentTables
RESULT: 
Script completed
=====================================
22:03:57,041 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-PropertyValueTables
RESULT: 
Script completed
=====================================
22:03:57,041 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-AvmTables
RESULT: 
Script completed
=====================================
22:03:57,041 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-AuditTables
RESULT: 
Script completed
=====================================
22:03:57,042 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.3-JBPM-Extra
RESULT: 
Script completed
=====================================
22:03:57,042 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.4-JBPM-FK-indexes
RESULT: 
Script completed
=====================================
22:03:57,042 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V4.0-SubscriptionTables
RESULT: 
Script completed
=====================================
22:03:57,042 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.siteLoadPatch.swsdp
RESULT: 
Site swsdp imported.
=====================================
22:03:57,042 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.exampleJavaScript
RESULT: 
Imported view into bootstrap location: /app:company_home/app:dictionary/app:scripts (workspace://SpacesStore/2befe7d4-a6e0-4328-b396-e14a602fb632)
=====================================
22:03:57,053 INFO  [org.alfresco.repo.module.ModuleServiceImpl] Found 1 module(s).
22:03:57,098 INFO  [org.alfresco.repo.module.ModuleServiceImpl] Installing module 'org_alfresco_module_wcmquickstart' version 1.0.
22:03:57,108 DEBUG [org.alfresco.repo.module.ModuleComponentHelper] Started module 'ModuleDetails[{module.version=1.0, module.description=Web Quick Start, module.id=org_alfresco_module_wcmquickstart, module.repo.version.max=999, module.title=Web Quick Start, module.repo.version.min=3.3, module.installState=INSTALLED, module.installDate=2011-11-03T21:53:39.955+01:00}]' including 0components.
22:03:57,116 DEBUG [org.alfresco.repo.module.ModuleComponentHelper] Installed module found in distribution: org_alfresco_module_wcmquickstart
22:03:57,129 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [fileServers, default]
22:04:02,813 ERROR [org.alfresco.fileserver] Failed to get local domain/workgroup name, using default of WORKGROUP
22:04:02,813 ERROR [org.alfresco.fileserver] (This may be due to firewall settings or incorrect <broadcast> setting)
22:04:02,856 ERROR [org.alfresco.fileserver] [SMB] Server error : org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
22:04:02,870 ERROR [org.alfresco.fileserver] org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied
22:04:02,870 ERROR [org.alfresco.fileserver]    at org.alfresco.jlan.smb.server.nio.NIOCifsConnectionsHandler.initializeHandler(NIOCifsConnectionsHandler.java:259)
22:04:02,870 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [fileServers, default] complete
22:04:02,870 ERROR [org.alfresco.fileserver]    at org.alfresco.jlan.smb.server.SMBServer.run(SMBServer.java:472)
22:04:02,870 ERROR [org.alfresco.fileserver]    at java.lang.Thread.run(Thread.java:679)
22:04:02,870 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [imap, default]
22:04:02,948 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [imap, default] complete
22:04:02,948 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, outbound]
22:04:03,028 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, outbound] complete
22:04:03,028 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'email' subsystem, ID: [email, inbound]
22:04:03,121 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'email' subsystem, ID: [email, inbound] complete
22:04:03,121 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'googledocs' subsystem, ID: [googledocs, default]
22:04:03,214 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'googledocs' subsystem, ID: [googledocs, default] complete
22:04:03,214 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Subscriptions' subsystem, ID: [Subscriptions, default]
22:04:03,238 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Subscriptions' subsystem, ID: [Subscriptions, default] complete
22:04:03,239 INFO  [org.alfresco.repo.usage.UserUsageTrackingComponent] Disabled - clear non-missing user usages …
22:04:03,306 INFO  [org.alfresco.repo.usage.UserUsageTrackingComponent] Found 4 users to clear
22:04:03,399 INFO  [org.alfresco.repo.usage.UserUsageTrackingComponent] … cleared non-missing usages for 4 users
22:04:03,399 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [Synchronization, default]
22:04:03,573 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [Synchronization, default] complete
22:04:03,629 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_22-b22; maximum heap size 1706,688MB
22:04:03,630 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco started (Community). Current version: 4.0.0 (b 3835) schema 5.019. Originally installed version: 4.0.0 (b 3835) schema 5.019.
22:04:03,635 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default]
22:04:03,796 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'ActivitiesFeed' subsystem, ID: [ActivitiesFeed, default] complete
22:04:03,797 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Replication' subsystem, ID: [Replication, default]
22:04:03,817 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Replication' subsystem, ID: [Replication, default] complete
22:04:14,695 WARN  [org.springframework.extensions.webscripts.DeclarativeRegistry] Unable to register script classpath:webscripts/org/springframework/extensions/cmis/content.get.desc.xml due to error: 10030000 Web Script document org/springframework/extensions/cmis/content.get.desc.xml is attempting to define the url '/cmis/content:GET' already defined by org/alfresco/cmis/client/content.get.desc.xml
22:04:14,695 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 476 Web Scripts (+1 failed), 744 URLs
22:04:14,695 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 2 Package Description Documents (+0 failed) 
22:04:14,695 INFO  [org.springframework.extensions.webscripts.DeclarativeRegistry] Registered 1 Schema Description Documents (+0 failed) 
22:04:14,697 INFO  [org.springframework.extensions.webscripts.AbstractRuntimeContainer] Initialised Repository Web Script Container (in 7252.477ms)
22:04:14,709 INFO  [org.springframework.extensions.webscripts.TemplateProcessorRegistry] Registered template processor freemarker for extension ftl
22:04:14,710 INFO  [org.springframework.extensions.webscripts.ScriptProcessorRegistry] Registered script processor javascript for extension js‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

¿Alguna idea?

Gracias

[cristinamr]

Buenas Albertomi.

Creo que la clave está aquí:

22:04:02,870 ERROR [org.alfresco.fileserver] org.alfresco.jlan.server.config.InvalidConfigurationException: Error initializing TCP-IP SMB session handler, Permission denied‍

¿El usuario con el que ejecutas el proceso tiene permisos o es owner de la carpeta de tomcat? Revisalo please y comentanos. Me da que puede ir por ahí los tiros.

Un saludo.