Tomcat startup

[sbudrez]

Since yesterday, when i "start the alfresco server", tomcat doesn't start anymore. Only mysql starts correctly as before. And thus i can't use alfresco!
I haven't changed anything on my system. Even on my other computer i get the same problem. I even tried to unistall & reinstall the whole thing, but i get the same problem.

It's a common problem? How do i solve this?
Thanks

[mikeh]

How do i solve this?

You could start by posting the log file..? Otherwise we're all guessing!

Thanks,
Mike

[sbudrez]

I'm sorry but i'm a newbie with this kind of things
I've found an "alfresco.log" file in the alfresco directory, I'm not sure if this is the file you need:

13:55:16,515 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/repository.properties]
13:55:16,515 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from class path resource [alfresco/domain/transaction.properties]
13:55:16,515 INFO  [org.alfresco.config.JndiPropertiesFactoryBean] Loading properties file from URL [file:/C:/Programmi/Alfresco/tomcat/shared/classes/alfresco-global.properties]
13:55:16,687 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:56:09,500 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Schema managed by database dialect org.hibernate.dialect.MySQLInnoDBDialect.
13:56:10,468 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-50555.sql (Generated).
13:56:19,609 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-50556.sql (Copied from classpath:alfresco/dbscripts/create/2.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-2.2-MappedFKIndexes.sql).
13:56:20,000 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-50557.sql (Copied from classpath:alfresco/dbscripts/create/2.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-2.2-Extra.sql).
13:56:20,703 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-50558.sql (Copied from classpath:alfresco/dbscripts/create/2.2/org.hibernate.dialect.MySQLInnoDBDialect/post-create-indexes-04.sql).
13:56:20,718 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-50559.sql (Copied from classpath:alfresco/dbscripts/create/3.0/org.hibernate.dialect.MySQLInnoDBDialect/create-activities-extras.sql).
13:56:21,031 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-50560.sql (Copied from classpath:alfresco/dbscripts/create/3.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-3.2-LockTables.sql).
13:56:21,046 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Executing database script C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-Update-50561.sql (Copied from classpath:alfresco/dbscripts/create/3.2/org.hibernate.dialect.MySQLInnoDBDialect/AlfrescoPostCreate-3.2-ContentTables.sql).
13:56:21,203 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] All executed statements:  C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-All_Statements-50562.sql.
13:56:22,859 INFO  [org.alfresco.repo.domain.schema.SchemaBootstrap] Normalized schema dumped to file C:\Programmi\Alfresco\tomcat\temp\Alfresco\AlfrescoSchema-MySQLInnoDBDialect-50563.xml.
13:56:25,328 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'thirdparty' subsystem, ID: [default]
13:56:25,421 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:56:31,234 WARN  [org.alfresco.util.OpenOfficeConnectionTester] An initial OpenOffice connection could not be established.
13:56:31,234 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'thirdparty' subsystem, ID: [default] complete
13:58:00,109 INFO  [org.alfresco.repo.admin.ConfigurationChecker] The Alfresco root data directory ('dir.root') is: C:\Programmi\Alfresco\alf_data
13:58:00,187 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] Checking for patches to apply …
13:58:06,531 INFO  [org.alfresco.repo.admin.patch.PatchExecuter]    Applying patch 'patch.wcmFolders' (Ensures the existance of the WCM specific 'Web Projects' and 'Web Forms' folders.).
13:58:06,828 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.0-0-CreateActivitiesExtras
RESULT: 
Script completed
=====================================
13:58:06,828 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-ContentTables
RESULT: 
Script completed
=====================================
13:58:06,828 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.db-V3.2-LockTables
RESULT: 
Script completed
=====================================
13:58:06,828 INFO  [org.alfresco.repo.admin.patch.PatchExecuter] 
=== Applied patch                 === 
ID: patch.wcmFolders
RESULT: 
The Web Projects folder was successfully created: workspace://SpacesStore/2d22037d-6cf1-4f30-b057-fa372e0f22d6
The Web Forms folder was successfully created: workspace://SpacesStore/2d22037d-6cf1-4f30-b057-fa372e0f22d6
=====================================
13:58:06,937 INFO  [org.alfresco.repo.module.ModuleServiceImpl] Found 1 module(s).
13:58:07,031 INFO  [org.alfresco.repo.module.ModuleServiceImpl] Installing module 'org.alfresco.module.vti' version 1.2.
13:58:09,218 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'fileServers' subsystem, ID: [default]
13:58:09,250 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:58:09,718 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Authentication' subsystem, ID: [managed, alfrescoNtlm1]
13:58:09,781 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:58:11,671 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Authentication' subsystem, ID: [managed, alfrescoNtlm1] complete
13:58:11,781 WARN  [org.alfresco.fileserver] CIFS server name is longer than 15 characters, truncated to YOUR-A47779BE2C
13:58:11,921 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'fileServers' subsystem, ID: [default] complete
13:58:11,921 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'imap' subsystem, ID: [default]
13:58:11,953 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:58:12,046 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'imap' subsystem, ID: [default] complete
13:58:12,046 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'Synchronization' subsystem, ID: [default]
13:58:12,171 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:58:12,203 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'Synchronization' subsystem, ID: [default] complete
13:58:13,890 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco JVM - v1.6.0_06-b02; maximum heap size 506,313MB
13:58:13,890 INFO  [org.alfresco.service.descriptor.DescriptorService] Alfresco started (Community): Current version 3.2.0 (2039) schema 2019 - Installed version 3.2.0 (2039) schema 2019
13:58:14,546 INFO  [org.alfresco.module.vti.VtiServer] Vti server started successfully on port: 7070
13:58:23,390 INFO  [org.alfresco.util.OpenOfficeConnectionTester] The OpenOffice connection was re-established.
13:58:41,218 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Starting 'wcm_deployment_receiver' subsystem, ID: [default]
13:58:41,265 INFO  [org.alfresco.config.JndiPropertyPlaceholderConfigurer] Loading properties file from class path resource [alfresco/alfresco-shared.properties]
13:58:41,437 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Startup of 'wcm_deployment_receiver' subsystem, ID: [default] complete
13:58:49,140 INFO  [org.alfresco.config.JBossEnabledWebApplicationContext] Refreshing org.alfresco.config.JBossEnabledWebApplicationContext@18c845e: display name [Root WebApplicationContext]; startup date [Mon Aug 10 13:58:49 CEST 2009]; root of context hierarchy
13:58:50,015 INFO  [org.alfresco.config.JBossEnabledWebApplicationContext] Bean factory for application context [org.alfresco.config.JBossEnabledWebApplicationContext@18c845e]: org.springframework.beans.factory.support.DefaultListableBeanFactory@854cac
13:58:53,125 INFO  [org.alfresco.web.scripts.DeclarativeRegistry] Registered 24 Web Scripts (+0 failed), 26 URLs
13:58:53,343 INFO  [org.alfresco.web.scripts.AbstractRuntimeContainer] Initialised Presentation Web Script Container (in 981.8217ms)
13:58:53,671 INFO  [org.alfresco.web.scripts.DeclarativeRegistry] Registered 42 Web Scripts (+0 failed), 44 URLs
13:58:53,687 INFO  [org.alfresco.web.scripts.AbstractRuntimeContainer] Initialised WebFramework Web Script Container (in 344.5723ms)
13:58:53,781 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
14:00:16,359 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
14:15:02,937 INFO  [org.alfresco.web.site.FrameworkHelper] Successfully Initialized Web Framework
14:23:01,828 INFO  [org.alfresco.config.JBossEnabledWebApplicationContext] Closing org.alfresco.config.JBossEnabledWebApplicationContext@18c845e: display name [Root WebApplicationContext]; startup date [Mon Aug 10 13:58:49 CEST 2009]; root of context hierarchy
14:23:03,640 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'wcm_deployment_receiver' subsystem, ID: [default]
14:23:03,640 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'wcm_deployment_receiver' subsystem, ID: [default]
14:23:03,718 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'fileServers' subsystem, ID: [default]
14:23:05,781 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'fileServers' subsystem, ID: [default]
14:23:05,781 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'imap' subsystem, ID: [default]
14:23:05,781 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'imap' subsystem, ID: [default]
14:23:05,781 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'Synchronization' subsystem, ID: [default]
14:23:05,781 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'Synchronization' subsystem, ID: [default]
14:23:05,828 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'thirdparty' subsystem, ID: [default]
14:23:05,828 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'thirdparty' subsystem, ID: [default]
14:23:05,843 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopping 'Authentication' subsystem, ID: [managed, alfrescoNtlm1]
14:23:05,843 INFO  [org.alfresco.repo.management.subsystems.ChildApplicationContextFactory] Stopped 'Authentication' subsystem, ID: [managed, alfrescoNtlm1]
‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍‍

[mikeh]

Nothing wrong there - looks like a clean bootstrap until it was shut down..?

Mike

[sbudrez]

Uhmm wait…
Now i see i've posted the wrong file. There are many .log files in the alfresco directory, each with the date in the file name (except those i already opened once with notepad). What i've posted before is an old one…
But i can't find a recent log file in this directory: the newest is far too old 09.12.2009, which means before the problem came up
Maybe since tomcat does not start the log file is not created??

[mikeh]

Try catalina.out

Thanks,
Mike

[sbudrez]

I've found the problem!
I was trying to install SIDE-labs, following the guide at http://www.side-labs.org/wiki/index.php/Documentation:User:Installation
At "Step 2: Configure JDK 1.5/1.6" i've set the JAVA_HOME and JRE_HOME, but this seems to create problems with alfresco (tomcat doesn't start)

Is there a way to get both things working?
Thanks

[mikeh]

I've no idea what the SIDE-labs stuff does - I'll send a PM pointing to this topic.

Thanks,
Mike

[jck]

Hi,
Thanks to direct all questions related to SIDE-Labs on the corresponding SIDE-Labs forums (http://www.side-labs.org/forums/).

This question has been answered on the following URL:
* http://www.side-labs.org/forums/viewtopic.php?f=13&p=911#p911

JC