Re: Orbeon won't run on JBoss 5.0, need help

Posted by jpresende on
URL: https://discuss.orbeon.com/Orbeon-won-t-run-on-JBoss-5-0-need-help-tp43341p43342.html

Erick, I don't get it, what do you mean? You think if I set up the server to use WAR's jars first it will work?

When I download a clean install of JBoss 5.0.1 and deploy orbeon.war in it, I get a log message saying that JBoss needs a later version of Xerces (needs 2.9.1, and orbeon uses 2.9.0). It also complains about Xalan and some other stuff related to Log4j. I'm using the current nightly build of Orbeon.

If you want to replicate this error simply download JBoss 5.0.1 (stable) and the nightly build of orbeon, deploy it and watch. If not, please just take a look at the log that follows.

I highlighted the log parts where it complains about the orbeon classes, if anyone could please help me with this issue I'd be very glad. I've been stuck with this for more than a week now.

Thanks in advance.

======== JBOSS 5.0.1 LOG =============================================================

JAVA_HOME is not set. Unexpected results may occur.
Set JAVA_HOME to the directory of your local JDK to avoid this message.
===============================================================================

  JBoss Bootstrap Environment

  JBOSS_HOME: C:\jboss-5.0.1.GA

  JAVA: java

  JAVA_OPTS: -Dprogram.name=run.bat -Xms128m -Xmx512m -XX:MaxPermSize=256m -Dorg.jboss.resolver.warning=true -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000

  CLASSPATH: ;C:\jboss-5.0.1.GA\bin\run.jar

===============================================================================

09:47:40,734 INFO  [ServerImpl] Starting JBoss (Microcontainer)...
09:47:40,734 INFO  [ServerImpl] Release ID: JBoss [Morpheus] 5.0.1.GA (build: SVNTag=JBoss_5_0_1_GA date=200902232048)
09:47:40,734 INFO  [ServerImpl] Bootstrap URL: null
09:47:40,734 INFO  [ServerImpl] Home Dir: C:\jboss-5.0.1.GA
09:47:40,734 INFO  [ServerImpl] Home URL: file:/C:/jboss-5.0.1.GA/
09:47:40,734 INFO  [ServerImpl] Library URL: file:/C:/jboss-5.0.1.GA/lib/
09:47:40,734 INFO  [ServerImpl] Patch URL: null
09:47:40,734 INFO  [ServerImpl] Common Base URL: file:/C:/jboss-5.0.1.GA/common/
09:47:40,734 INFO  [ServerImpl] Common Library URL: file:/C:/jboss-5.0.1.GA/common/lib/
09:47:40,734 INFO  [ServerImpl] Server Name: default
09:47:40,734 INFO  [ServerImpl] Server Base Dir: C:\jboss-5.0.1.GA\server
09:47:40,734 INFO  [ServerImpl] Server Base URL: file:/C:/jboss-5.0.1.GA/server/
09:47:40,734 INFO  [ServerImpl] Server Config URL: file:/C:/jboss-5.0.1.GA/server/default/conf/
09:47:40,734 INFO  [ServerImpl] Server Home Dir: C:\jboss-5.0.1.GA\server\default
09:47:40,734 INFO  [ServerImpl] Server Home URL: file:/C:/jboss-5.0.1.GA/server/default/
09:47:40,734 INFO  [ServerImpl] Server Data Dir: C:\jboss-5.0.1.GA\server\default\data
09:47:40,734 INFO  [ServerImpl] Server Library URL: file:/C:/jboss-5.0.1.GA/server/default/lib/
09:47:40,734 INFO  [ServerImpl] Server Log Dir: C:\jboss-5.0.1.GA\server\default\log
09:47:40,734 INFO  [ServerImpl] Server Native Dir: C:\jboss-5.0.1.GA\server\default\tmp\native
09:47:40,734 INFO  [ServerImpl] Server Temp Dir: C:\jboss-5.0.1.GA\server\default\tmp
09:47:40,734 INFO  [ServerImpl] Server Temp Deploy Dir: C:\jboss-5.0.1.GA\server\default\tmp\deploy
09:47:41,187 INFO  [ServerImpl] Starting Microcontainer, bootstrapURL=file:/C:/jboss-5.0.1.GA/server/default/conf/bootstrap.xml
09:47:41,578 INFO  [VFSCacheFactory] Initializing VFSCache [org.jboss.virtual.plugins.cache.CombinedVFSCache]
09:47:41,578 INFO  [VFSCacheFactory] Using VFSCache [CombinedVFSCache[real-cache: null]]
09:47:41,765 INFO  [CopyMechanism] VFS temp dir: C:\jboss-5.0.1.GA\server\default\tmp
09:47:41,765 INFO  [ZipEntryContext] VFS force nested jars copy-mode is enabled.
09:47:42,390 INFO  [ServerInfo] Java version: 1.6.0_12,Sun Microsystems Inc.
09:47:42,390 INFO  [ServerInfo] Java Runtime: Java(TM) SE Runtime Environment (build 1.6.0_12-b04)
09:47:42,390 INFO  [ServerInfo] Java VM: Java HotSpot(TM) Client VM 11.2-b01,Sun Microsystems Inc.
09:47:42,390 INFO  [ServerInfo] OS-System: Windows XP 5.1,x86
09:47:42,421 INFO  [JMXKernel] Legacy JMX core initialized
09:47:43,609 INFO  [ProfileServiceImpl] Loading profile: default from: org.jboss.system.server.profileservice.repository.SerializableDeploymentRepository@ba5a81(root=C:\jboss-5.0.1.GA\server, key=org.
jboss.profileservice.spi.ProfileKey@143b82c3[domain=default,server=default,name=default])
09:47:43,609 INFO  [ProfileImpl] Using repository:org.jboss.system.server.profileservice.repository.SerializableDeploymentRepository@ba5a81(root=C:\jboss-5.0.1.GA\server, key=org.jboss.profileservice.
spi.ProfileKey@143b82c3[domain=default,server=default,name=default])
09:47:43,609 INFO  [ProfileServiceImpl] Loaded profile: ProfileImpl@1b1ff47{key=org.jboss.profileservice.spi.ProfileKey@143b82c3[domain=default,server=default,name=default]}
09:47:44,703 INFO  [WebService] Using RMI server codebase: http://127.0.0.1:8083/
09:47:49,921 INFO  [NativeServerConfig] JBoss Web Services - Stack Native Core
09:47:49,921 INFO  [NativeServerConfig] 3.0.5.GA
09:48:08,125 INFO  [JMXConnectorServerService] JMX Connector server: service:jmx:rmi://127.0.0.1/jndi/rmi://127.0.0.1:1090/jmxconnector
09:48:08,296 INFO  [MailService] Mail Service bound to java:/Mail
09:48:10,406 WARN  [JBossASSecurityMetadataStore] WARNING! POTENTIAL SECURITY RISK. It has been detected that the MessageSucker component which sucks messages from one node to another has not had its
password changed from the installation default. Please see the JBoss Messaging user guide for instructions on how to do this.
09:48:10,421 WARN  [AnnotationCreator] No ClassLoader provided, using TCCL: org.jboss.managed.api.annotation.ManagementComponent
09:48:10,593 INFO  [TransactionManagerService] JBossTS Transaction Service (JTA version) - JBoss Inc.
09:48:10,593 INFO  [TransactionManagerService] Setting up property manager MBean and JMX layer
09:48:10,843 INFO  [TransactionManagerService] Initializing recovery manager
09:48:11,015 INFO  [TransactionManagerService] Recovery manager configured
09:48:11,015 INFO  [TransactionManagerService] Binding TransactionManager JNDI Reference
09:48:11,062 INFO  [TransactionManagerService] Starting transaction recovery manager
09:48:11,531 INFO  [Http11Protocol] Initializing Coyote HTTP/1.1 on http-127.0.0.1-8080
09:48:11,531 INFO  [AjpProtocol] Initializing Coyote AJP/1.3 on ajp-127.0.0.1-8009
09:48:11,531 INFO  [StandardService] Starting service jboss.web
09:48:11,546 INFO  [StandardEngine] Starting Servlet Engine: JBoss Web/2.1.2.GA
09:48:11,625 INFO  [Catalina] Server startup in 162 ms
09:48:11,671 INFO  [TomcatDeployment] deploy, ctxPath=/invoker
09:48:12,812 INFO  [TomcatDeployment] deploy, ctxPath=/jbossws
09:48:12,859 INFO  [TomcatDeployment] deploy, ctxPath=/web-console
09:48:13,250 INFO  [RARDeployment] Required license terms exist, view vfszip:/C:/jboss-5.0.1.GA/server/default/deploy/jboss-local-jdbc.rar/META-INF/ra.xml
09:48:13,281 INFO  [RARDeployment] Required license terms exist, view vfszip:/C:/jboss-5.0.1.GA/server/default/deploy/jboss-xa-jdbc.rar/META-INF/ra.xml
09:48:13,343 INFO  [RARDeployment] Required license terms exist, view vfszip:/C:/jboss-5.0.1.GA/server/default/deploy/jms-ra.rar/META-INF/ra.xml
09:48:13,375 INFO  [RARDeployment] Required license terms exist, view vfszip:/C:/jboss-5.0.1.GA/server/default/deploy/mail-ra.rar/META-INF/ra.xml
09:48:13,421 INFO  [RARDeployment] Required license terms exist, view vfszip:/C:/jboss-5.0.1.GA/server/default/deploy/quartz-ra.rar/META-INF/ra.xml
09:48:13,531 INFO  [SimpleThreadPool] Job execution threads will use class loader of thread: main
09:48:13,578 INFO  [QuartzScheduler] Quartz Scheduler v.1.5.2 created.
09:48:13,593 INFO  [RAMJobStore] RAMJobStore initialized.
09:48:13,609 INFO  [StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
09:48:13,640 INFO  [StdSchedulerFactory] Quartz scheduler version: 1.5.2
09:48:13,656 INFO  [QuartzScheduler] Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
09:48:13,812 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=bpmDS' to JNDI name 'java:bpmDS'
09:48:13,906 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=coreDS' to JNDI name 'java:coreDS'
09:48:14,968 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
09:48:15,062 WARN  [loggerI18N] [com.arjuna.ats.internal.jta.transaction.arjunacore.lastResource.startupWarning] [com.arjuna.ats.internal.jta.transaction.arjunacore.lastResource.startupWarning] You ha
ve chosen to enable multiple last resources in the transaction manager. This is transactionally unsafe and should not be relied upon.
09:48:15,609 INFO  [ServerPeer] JBoss Messaging 1.4.1.GA server [0] started
09:48:15,703 INFO  [TopicService] Topic[/topic/eafTopic] started, fullSize=200000, pageSize=2000, downCacheSize=2000
09:48:15,734 INFO  [QueueService] Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
09:48:15,765 WARN  [ConnectionFactoryJNDIMapper] supportsFailover attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is non c
lustered. So connection factory will *not* support failover
09:48:15,796 WARN  [ConnectionFactoryJNDIMapper] supportsLoadBalancing attribute is true on connection factory: jboss.messaging.connectionfactory:service=ClusteredConnectionFactory but post office is
non clustered. So connection factory will *not* support load balancing
09:48:15,921 INFO  [ConnectionFactory] Connector bisocket://127.0.0.1:4457 has leasing enabled, lease period 10000 milliseconds
09:48:15,937 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@1af895e started
09:48:15,953 INFO  [QueueService] Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
09:48:15,984 INFO  [ConnectionFactory] Connector bisocket://127.0.0.1:4457 has leasing enabled, lease period 10000 milliseconds
09:48:16,000 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@58744d started
09:48:16,015 INFO  [ConnectionFactory] Connector bisocket://127.0.0.1:4457 has leasing enabled, lease period 10000 milliseconds
09:48:16,031 INFO  [ConnectionFactory] org.jboss.jms.server.connectionfactory.ConnectionFactory@1fac6e2 started
09:48:16,156 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
09:48:16,234 INFO  [ConnectionFactoryBindingService] Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=eafDS' to JNDI name 'java:eafDS'
09:48:16,281 INFO  [TomcatDeployment] deploy, ctxPath=/
09:48:16,343 INFO  [TomcatDeployment] deploy, ctxPath=/jmx-console

09:48:16,421 INFO  [TomcatDeployment] deploy, ctxPath=/orbeon
09:48:17,046 ERROR [STDERR] log4j:ERROR A "org.jboss.logging.appender.FileAppender" object is not assignable to a "org.apache.log4j.Appender" variable.
09:48:17,078 ERROR [STDERR] log4j:ERROR The class "org.apache.log4j.Appender" was loaded by
09:48:17,093 ERROR [STDERR] log4j:ERROR [BaseClassLoader@134af1{vfsfile:/C:/jboss-5.0.1.GA/server/default/deploy/orbeon.war/}] whereas object of type
09:48:17,109 ERROR [STDERR] log4j:ERROR "org.jboss.logging.appender.FileAppender" was loaded by [org.jboss.system.NoAnnotationURLClassLoader@df8ff1].
09:48:17,125 ERROR [STDERR] log4j:ERROR Could not instantiate appender named "FILE".
09:48:17,218 INFO  [STDOUT] 09:48:17,218 INFO  [WebAppContext] Starting Orbeon Forms Release dev-3.7.1.200904082224
09:48:17,234 ERROR [STDERR] Starting Orbeon Forms Release dev-3.7.1.200904082224
09:48:17,265 INFO  [STDOUT] 09:48:17,265 INFO  [WebAppContext] Initializing Resource Manager with: {oxf.resources.priority.1.oxf.resources.webapp.rootdir=/WEB-INF/resources, oxf.resources.priority.1=o
rg.orbeon.oxf.resources.WebAppResourceManagerFactory, oxf.resources.priority.2=org.orbeon.oxf.resources.ClassLoaderResourceManagerFactory, oxf.resources.factory=org.orbeon.oxf.resources.PriorityResour
ceManagerFactory, org.orbeon.oxf.resources.WebAppResourceManagerImplServletContext=org.apache.catalina.core.ApplicationContextFacade@1d5e5d7}
09:48:17,328 ERROR [STDERR] Initializing Resource Manager with: {oxf.resources.priority.1.oxf.resources.webapp.rootdir=/WEB-INF/resources, oxf.resources.priority.1=org.orbeon.oxf.resources.WebAppResou
rceManagerFactory, oxf.resources.priority.2=org.orbeon.oxf.resources.ClassLoaderResourceManagerFactory, oxf.resources.factory=org.orbeon.oxf.resources.PriorityResourceManagerFactory, org.orbeon.oxf.re
sources.WebAppResourceManagerImplServletContext=org.apache.catalina.core.ApplicationContextFacade@1d5e5d7}
09:48:22,000 ERROR [STDERR] Looking for a valid Parser...
Checking for Xerces, found version Xerces-J 2.9.0 needed version Xerces-J 2.9.1
Warning: Failed find a valid Parser!

Please add an appropriate Parser to the class-path, e.g. in the 'endorsed' folder of the servlet container or in the 'endorsed' folder of the JRE.

09:48:22,062 ERROR [STDERR] Looking for a valid Transformer...
Checking for Saxon, found version 8.8 needed version 8.9.0
Checking for Xalan, found version Xalan Java 2.5.1 needed version Xalan Java 2.7.1
Warning: Failed find a valid Transformer!

Please add an appropriate Transformer to the class-path, e.g. in the 'endorsed' folder of the servlet container or in the 'endorsed' folder of the JRE.
09:48:22,171 ERROR [STDERR] Using parser org.orbeon.oxf.xml.xerces.XercesSAXParser
09:48:22,187 ERROR [STDERR] Using transformer orbeon.apache.xalan.transformer.TransformerIdentityImpl

09:48:22,234 INFO  [Http11Protocol] Starting Coyote HTTP/1.1 on http-127.0.0.1-8080
09:48:22,265 INFO  [AjpProtocol] Starting Coyote AJP/1.3 on ajp-127.0.0.1-8009
09:48:22,281 INFO  [ServerImpl] JBoss (Microcontainer) [5.0.1.GA (build: SVNTag=JBoss_5_0_1_GA date=200902232048)] Started in 41s:547ms