Page 1 of 1

Openemm Starting Problem

Posted: Mon Jan 03, 2011 5:55 am
by almamunbd
Hi,
I have setup Openemm 6.2 on a centos 5.5 64 bit server, but getting problem starting it correctly. Sometimes it starts correctly and works fine, but if i stop it and restarts then the startup script says it's started but the page never loads. I checked server log and found this.

Resin-3.0.28 (built Mon, 18 May 2009 02:16:38 PDT)
Copyright(c) 1998-2006 Caucho Technology. All rights reserved.

-bash-3.2$ OpenEMM.sh start
Start /home/openemm/bin/scripts/bav-update.py .. done.
Start /home/openemm/bin/scripts/bav-trigger.py .. done.
Start /home/openemm/bin/scripts/bavd.py .. done.
Start /home/openemm/bin/bav -L INFO .. done.
Start python /home/openemm/bin/scripts/recovery.py .. done.
Start /home/openemm/bin/scripts/update.py bounce account .. done.
Start /home/openemm/bin/scripts/pickdist.py .. done.
Stopping obsolete sendmail processes: done.
Starting sendmails: listener client queue clientmqueue admin queue mail queue done.
Start /home/openemm/bin/scripts/slrtscn.py .. done.
Resin httpd start at Sun Jan 2 15:36:50 MST 2011


tail -f /home/openemm/webapps/core/log/openemm_stdout.log

Starting Resin on Sun, 02 Jan 2011 15:36:50 -0700 (MST)

[15:36:51.576]Server[core] starting
[15:36:51.576]
[15:36:51.576]Linux 2.6.18-194.8.1.el5 amd64
[15:36:51.577]Java 17.0-b16, 64, mixed mode, ANSI_X3.4-1968, en, Sun Microsystems Inc.
[15:36:51.577]resin.home = /home/openemm
[15:36:51.577]server.root = /home/openemm/webapps/core
[15:36:51.577]
[15:36:51.584]http listening to *:8080
[15:36:51.596]Host[] starting
[15:36:52.120]WebApp[http://localhost:8080] starting
2011-01-02 15:36:52,201: INFO [main] org.springframework.web.context.ContextLoader - Root WebApplicationContext: initialization started
[15:36:52.202]Loading Spring root WebApplicationContext
2011-01-02 15:36:52,323: INFO [main] org.springframework.core.CollectionFactory - Commons Collections 3.x available
2011-01-02 15:36:52,360: INFO [main] org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/applicationContext.xml]
2011-01-02 15:36:52,662: INFO [main] org.hibernate.dialect.Dialect - Using dialect: org.hibernate.dialect.MySQLDialect
2011-01-02 15:36:52,781: INFO [main] org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/dataAccessContext.xml]
2011-01-02 15:36:52,854: INFO [main] org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/cronContext.xml]
2011-01-02 15:36:52,884: INFO [main] org.springframework.beans.factory.xml.XmlBeanDefinitionReader - Loading XML bean definitions from ServletContext resource [/WEB-INF/cms/cmsContext.xml]
2011-01-02 15:36:52,887: INFO [main] org.springframework.beans.factory.support.DefaultListableBeanFactory - Overriding bean definition for bean 'propertyConfigurer': replacing [Root bean: class [org.springframework.beans.factory.config.PropertyPlaceholderConfigurer]; abstract=false; singleton=true; lazyInit=false; autowire=0; dependencyCheck=0; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null; defined in ServletContext resource [/WEB-INF/applicationContext.xml]] with [Root bean: class [org.springframework.beans.factory.config.PropertyPlaceholderConfigurer]; abstract=false; singleton=true; lazyInit=false; autowire=0; dependencyCheck=0; factoryBeanName=null; factoryMethodName=null; initMethodName=null; destroyMethodName=null; defined in ServletContext resource [/WEB-INF/cms/cmsContext.xml]]
2011-01-02 15:36:52,908: INFO [main] org.springframework.web.context.support.XmlWebApplicationContext - Bean factory for application context [Root WebApplicationContext]: org.springframework.beans.factory.support.DefaultListableBeanFactory defining beans [propertyConfigurer,messageSource,TargetRepresentation,TargetNodeString,TargetNodeNumeric,TargetNodeDate,UserForm,EmmAction,Mailinglist,TrackableLink,Mailing,MaildropEntry,MediatypeEmail,Mediatype,MailingComponent,DeliveryStat,CampaignStatEntry,DomainStat,IPStat,MailingStat,MailingStatEntry,URLStatEntry,Mailgun,DynamicTag,DynamicTagContent,TagDetails,Recipient,Campaign,BindingEntry,Target,DatasourceDescription,Title,ProfileField,Company,Mailloop,Admin,AdminGroup,UID,ExportPredef,CustomerImportStatus,EmmLayout,mailgunCache,imageCache,companyCache,versionControlService,columnInfoService,mailingcontentService,AdminDao,AdminGroupDao,BindingEntryDao,BlacklistDao,CampaignDao,CompanyDao,DynamicTagDao,EmmActionDao,ExportPredefDao,LoginTrackDao,MaildropStatusDao,MailingComponentDao,MailingDao,MailinglistDao,MailloopDao,OnepixelDao,ProfileFieldDao,RecipientDao,TargetDao,TitleDao,TrackableLinkDao,UserFormDao,versionControlDao,EmmLayoutDao,ColumnInfoDao,GetArchiveList,GetArchiveMailing,ActivateDoubleOptIn,SubscribeCustomer,UnsubscribeCustomer,UpdateCustomer,GetCustomer,ExecuteScript,SendMailing,ServiceMail,workerExecutorService,onlinehelp.languages,NewImportWizardService,ImportRecipientsDao,ImportLoggerDao,ImportProfile,ColumnMapping,ImportProfileDao,EmbeddedClickStatDao,EmbeddedClickStatService,EcsRecipientsProvider,/ecs_stat,dataSource,sessionFactory,transactionManager,Ruler,dateBasedMailingsJob,delayedMailingsJob,dateBasedMailingsCronTrigger,delayedMailingsCronTrigger,cleanDB,cleanDBJob,cleanDBCronTrigger,loginTrackTableCleanerJobBean,loginTrackTableCleanerJobTrigger,org.springframework.scheduling.quartz.SchedulerFactoryBean,cmsDataSource,CmsMailingDao,CMTemplateDao,MediaFileDao,ContentModuleTypeDao,ContentModuleDao,CMTemplateManager,ContentModuleTypeManager,ContentModuleManager,MediaFileManager,ClassicTemplateGenerator]; root of BeanFactory hierarchy
2011-01-02 15:36:52,927: INFO [main] org.springframework.web.context.support.XmlWebApplicationContext - 119 beans defined in application context [Root WebApplicationContext]
2011-01-02 15:36:52,977: INFO [main] org.springframework.beans.factory.config.PropertyPlaceholderConfigurer - Loading properties file from class path resource [emm.properties]
2011-01-02 15:36:52,978: INFO [main] org.springframework.beans.factory.config.PropertyPlaceholderConfigurer - Loading properties file from class path resource [cms.properties]
2011-01-02 15:36:53,003: INFO [main] org.springframework.web.context.support.XmlWebApplicationContext - Using MessageSource [org.springframework.context.support.ResourceBundleMessageSource: basenames=[messages]]
2011-01-02 15:36:53,006: INFO [main] org.springframework.web.context.support.XmlWebApplicationContext - Unable to locate ApplicationEventMulticaster with name 'applicationEventMulticaster': using default [org.springframework.context.event.SimpleApplicationEventMulticaster@451415c8]
2011-01-02 15:36:53,012: INFO [main] org.springframework.ui.context.support.UiApplicationContextUtils - Unable to locate ThemeSource with name 'themeSource': using default [org.springframework.ui.context.support.ResourceBundleThemeSource@328990e4]
2011-01-02 15:36:53,014: INFO [main] org.springframework.beans.factory.support.DefaultListableBeanFactory - Pre-instantiating singletons in factory [org.springframework.beans.factory.support.DefaultListableBeanFactory defining beans [propertyConfigurer,messageSource,TargetRepresentation,TargetNodeString,TargetNodeNumeric,TargetNodeDate,UserForm,EmmAction,Mailinglist,TrackableLink,Mailing,MaildropEntry,MediatypeEmail,Mediatype,MailingComponent,DeliveryStat,CampaignStatEntry,DomainStat,IPStat,MailingStat,MailingStatEntry,URLStatEntry,Mailgun,DynamicTag,DynamicTagContent,TagDetails,Recipient,Campaign,BindingEntry,Target,DatasourceDescription,Title,ProfileField,Company,Mailloop,Admin,AdminGroup,UID,ExportPredef,CustomerImportStatus,EmmLayout,mailgunCache,imageCache,companyCache,versionControlService,columnInfoService,mailingcontentService,AdminDao,AdminGroupDao,BindingEntryDao,BlacklistDao,CampaignDao,CompanyDao,DynamicTagDao,EmmActionDao,ExportPredefDao,LoginTrackDao,MaildropStatusDao,MailingComponentDao,MailingDao,MailinglistDao,MailloopDao,OnepixelDao,ProfileFieldDao,RecipientDao,TargetDao,TitleDao,TrackableLinkDao,UserFormDao,versionControlDao,EmmLayoutDao,ColumnInfoDao,GetArchiveList,GetArchiveMailing,ActivateDoubleOptIn,SubscribeCustomer,UnsubscribeCustomer,UpdateCustomer,GetCustomer,ExecuteScript,SendMailing,ServiceMail,workerExecutorService,onlinehelp.languages,NewImportWizardService,ImportRecipientsDao,ImportLoggerDao,ImportProfile,ColumnMapping,ImportProfileDao,EmbeddedClickStatDao,EmbeddedClickStatService,EcsRecipientsProvider,/ecs_stat,dataSource,sessionFactory,transactionManager,Ruler,dateBasedMailingsJob,delayedMailingsJob,dateBasedMailingsCronTrigger,delayedMailingsCronTrigger,cleanDB,cleanDBJob,cleanDBCronTrigger,loginTrackTableCleanerJobBean,loginTrackTableCleanerJobTrigger,org.springframework.scheduling.quartz.SchedulerFactoryBean,cmsDataSource,CmsMailingDao,CMTemplateDao,MediaFileDao,ContentModuleTypeDao,ContentModuleDao,CMTemplateManager,ContentModuleTypeManager,ContentModuleManager,MediaFileManager,ClassicTemplateGenerator]; root of BeanFactory hierarchy]
2011-01-02 15:36:53,155: INFO [main] org.hibernate.cfg.Environment - Hibernate 3.1.3
2011-01-02 15:36:53,160: INFO [main] org.hibernate.cfg.Environment - hibernate.properties not found
2011-01-02 15:36:53,162: INFO [main] org.hibernate.cfg.Environment - using CGLIB reflection optimizer
2011-01-02 15:36:53,162: INFO [main] org.hibernate.cfg.Environment - using JDK 1.4 java.sql.Timestamp handling
2011-01-02 15:36:53,439: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: Target -> dyn_target_tbl
2011-01-02 15:36:53,474: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: Company -> company_tbl
2011-01-02 15:36:53,483: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: Admin -> admin_tbl
2011-01-02 15:36:53,518: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: Admin.adminPermissions -> admin_permission_tbl
2011-01-02 15:36:53,530: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: AdminGroup -> admin_group_tbl
2011-01-02 15:36:53,531: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: AdminGroup.groupPermissions -> admin_group_permission_tbl
2011-01-02 15:36:53,537: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: EmmLayout -> emm_layout_tbl
2011-01-02 15:36:53,543: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: DynamicTag -> dyn_name_tbl
2011-01-02 15:36:53,549: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: DynamicTagContent -> dyn_content_tbl
2011-01-02 15:36:53,559: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: Mailing -> mailing_tbl
2011-01-02 15:36:53,560: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: Mailing.mediatypes -> mailing_mt_tbl
2011-01-02 15:36:53,562: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: MailingComponentEmbedded -> component_tbl
2011-01-02 15:36:53,562: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: DynamicTagEmbedded -> dyn_name_tbl
2011-01-02 15:36:53,563: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: TrackableLinkEmbedded -> rdir_url_tbl
2011-01-02 15:36:53,563: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: DynamicTagContentEmbedded -> dyn_content_tbl
2011-01-02 15:36:53,564: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: MaildropEntryEmbedded -> maildrop_status_tbl
2011-01-02 15:36:53,570: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: MailingComponent -> component_tbl
2011-01-02 15:36:53,579: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: Title -> title_tbl
2011-01-02 15:36:53,579: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: Title.titleGender -> title_gender_tbl
2011-01-02 15:36:53,588: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: DatasourceDescription -> datasource_description_tbl
2011-01-02 15:36:53,599: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: CustomerImportStatus -> customer_import_status_tbl
2011-01-02 15:36:53,599: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: CustomerImportStatus.errors -> customer_import_errors_tbl
2011-01-02 15:36:53,609: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: UserForm -> userform_tbl
2011-01-02 15:36:53,619: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: EmmAction -> rdir_action_tbl
2011-01-02 15:36:53,628: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: Mailinglist -> mailinglist_tbl
2011-01-02 15:36:53,638: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: TrackableLink -> rdir_url_tbl
2011-01-02 15:36:53,648: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: ExportPredef -> export_predef_tbl
2011-01-02 15:36:53,657: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: Mailloop -> mailloop_tbl
2011-01-02 15:36:53,666: INFO [main] org.hibernate.cfg.HbmBinder - Mapping class: ProfileField -> customer_field_tbl
2011-01-02 15:36:53,667: INFO [main] org.springframework.orm.hibernate3.LocalSessionFactoryBean - Building new Hibernate SessionFactory
2011-01-02 15:36:53,669: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: DynamicTag.dynContent -> dyn_content_tbl
2011-01-02 15:36:53,669: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: Mailing.dynTags -> dyn_name_tbl
2011-01-02 15:36:53,670: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: Mailing.components -> component_tbl
2011-01-02 15:36:53,670: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: Mailing.trackableLinks -> rdir_url_tbl
2011-01-02 15:36:53,670: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: Mailing.maildropStatus -> maildrop_status_tbl
2011-01-02 15:36:53,670: INFO [main] org.hibernate.cfg.HbmBinder - Mapping collection: DynamicTagEmbedded.dynContent -> dyn_content_tbl
2011-01-02 15:36:53,889: INFO [main] org.hibernate.connection.ConnectionProviderFactory - Initializing connection provider: org.springframework.orm.hibernate3.LocalDataSourceConnectionProvider
2011-01-02 15:36:54,123: INFO [main] org.hibernate.cfg.SettingsFactory - RDBMS: MySQL, version: 5.0.77
2011-01-02 15:36:54,123: INFO [main] org.hibernate.cfg.SettingsFactory - JDBC driver: MySQL-AB JDBC Driver, version: mysql-connector-java-5.1.10 ( Revision: ${svn.Revision} )
2011-01-02 15:36:54,124: INFO [main] org.hibernate.dialect.Dialect - Using dialect: org.hibernate.dialect.MySQLDialect
2011-01-02 15:36:54,127: INFO [main] org.hibernate.transaction.TransactionFactoryFactory - Using default transaction strategy (direct JDBC transactions)
2011-01-02 15:36:54,132: INFO [main] org.hibernate.transaction.TransactionManagerLookupFactory - No TransactionManagerLookup configured (in JTA environment, use of read-write or transactional second-level cache is not recommended)
2011-01-02 15:36:54,132: INFO [main] org.hibernate.cfg.SettingsFactory - Automatic flush during beforeCompletion(): disabled
2011-01-02 15:36:54,132: INFO [main] org.hibernate.cfg.SettingsFactory - Automatic session close at end of transaction: disabled
2011-01-02 15:36:54,132: INFO [main] org.hibernate.cfg.SettingsFactory - JDBC batch size: 15
2011-01-02 15:36:54,132: INFO [main] org.hibernate.cfg.SettingsFactory - JDBC batch updates for versioned data: disabled
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - Scrollable result sets: enabled
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - JDBC3 getGeneratedKeys(): enabled
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - Connection release mode: on_close
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - Maximum outer join fetch depth: 2
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - Default batch fetch size: 1
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - Generate SQL with comments: disabled
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - Order SQL updates by primary key: disabled
2011-01-02 15:36:54,134: INFO [main] org.hibernate.cfg.SettingsFactory - Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
2011-01-02 15:36:54,140: INFO [main] org.hibernate.hql.ast.ASTQueryTranslatorFactory - Using ASTQueryTranslatorFactory
2011-01-02 15:36:54,140: INFO [main] org.hibernate.cfg.SettingsFactory - Query language substitutions: {}
2011-01-02 15:36:54,140: INFO [main] org.hibernate.cfg.SettingsFactory - Second-level cache: enabled
2011-01-02 15:36:54,140: INFO [main] org.hibernate.cfg.SettingsFactory - Query cache: disabled
2011-01-02 15:36:54,140: INFO [main] org.hibernate.cfg.SettingsFactory - Cache provider: org.hibernate.cache.EhCacheProvider
2011-01-02 15:36:54,145: INFO [main] org.hibernate.cfg.SettingsFactory - Optimize cache for minimal puts: disabled
2011-01-02 15:36:54,145: INFO [main] org.hibernate.cfg.SettingsFactory - Structured second-level cache entries: disabled
2011-01-02 15:36:54,158: INFO [main] org.hibernate.cfg.SettingsFactory - Echoing all SQL to stdout
2011-01-02 15:36:54,158: INFO [main] org.hibernate.cfg.SettingsFactory - Statistics: disabled
2011-01-02 15:36:54,158: INFO [main] org.hibernate.cfg.SettingsFactory - Deleted entity synthetic identifier rollback: disabled
2011-01-02 15:36:54,158: INFO [main] org.hibernate.cfg.SettingsFactory - Default entity-mode: pojo
2011-01-02 15:36:54,202: INFO [main] org.hibernate.impl.SessionFactoryImpl - building session factory
2011-01-02 15:36:54,213: WARN [main] net.sf.ehcache.config.Configurator - No configuration found. Configuring ehcache from ehcache-failsafe.xml found in the classpath: jar:file:/home/openemm/webapps/core/WEB-INF/lib/ehcache-1.1.jar!/ehcache-failsafe.xml
2011-01-02 15:36:54,914: INFO [main] org.hibernate.impl.SessionFactoryObjectFactory - Not binding factory to JNDI, no JNDI name configured
2011-01-02 15:36:55,042: INFO [main] org.springframework.orm.hibernate3.HibernateTransactionManager - Using DataSource [org.agnitas.dao.EnhBasicDataSource@4553f141] of Hibernate SessionFactory for HibernateTransactionManager
2011-01-02 15:36:55,148: INFO [main] org.quartz.simpl.SimpleThreadPool - Job execution threads will use class loader of thread: main
2011-01-02 15:36:55,170: INFO [main] org.quartz.core.QuartzScheduler - Quartz Scheduler v.1.5.1 created.
2011-01-02 15:36:55,173: INFO [main] org.quartz.simpl.RAMJobStore - RAMJobStore initialized.
2011-01-02 15:36:55,173: INFO [main] org.quartz.impl.StdSchedulerFactory - Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
2011-01-02 15:36:55,173: INFO [main] org.quartz.impl.StdSchedulerFactory - Quartz scheduler version: 1.5.1
2011-01-02 15:36:55,177: INFO [main] org.springframework.scheduling.quartz.SchedulerFactoryBean - Starting Quartz scheduler now
2011-01-02 15:36:55,178: INFO [main] org.quartz.core.QuartzScheduler - Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
2011-01-02 15:36:55,670: INFO [main] org.springframework.web.context.ContextLoader - Using context class [org.springframework.web.context.support.XmlWebApplicationContext] for root WebApplicationContext
2011-01-02 15:36:55,670: INFO [main] org.springframework.web.context.ContextLoader - Root WebApplicationContext: initialization completed in 3469 ms
2011-01-02 15:36:55,682: INFO [main] org.agnitas.web.filter.OpenSessionInViewFilter - Initializing filter 'OpenSessionInView'
2011-01-02 15:36:55,682: INFO [main] org.agnitas.web.filter.OpenSessionInViewFilter - Initializing filter 'OpenSessionInView'
2011-01-02 15:36:55,692: INFO [main] org.agnitas.web.filter.OpenSessionInViewFilter - Filter 'OpenSessionInView' configured successfully
2011-01-02 15:36:55,692: INFO [main] org.agnitas.web.filter.OpenSessionInViewFilter - Filter 'OpenSessionInView' configured successfully
[15:36:55.707]action: init


it stuck here rather than moving forward.


Can you please give me any idea how to fix it?

Thanks in advance

Posted: Mon Jan 03, 2011 9:26 am
by maschoff
Actually, we had the same problem last month from time to time. Launch either stopped at this step or took much longer than expected.

This happens when the web container is processing web.xml and wants to initiate the Action Struts servlet. To do this it has to analyzse file struts-config.xml and this file uses a DTD defined at http://jakarta.apache.org/struts/dtds/s ... ig_1_1.dtd. Our hunch is that this file was not accessible from time to time and created the problems.

Suggested workaround: Download this file, save it anywhere on your system and change the link in struts-config.xml accordingly.

Re: Openemm Starting Problem

Posted: Thu Sep 15, 2011 9:13 am
by kim88
Hi,
thank you, exactly what I'm looking for!My Local Cause