Deployment dependency on datasource problem
scotto Sep 17, 2008 12:18 AMHello.
I am trying to port an existing app from JBossAS 4.2.3.GA to 5.0.0.CR1. I cannot seem to get the deployer to resolve dependencies on the datasource. I'm sure its a simple problem, but for the life of me I cannot get my app to deploy.
I have simplified the app down to just one @Service bean to demonstrate the problem. The relevant parts of code are extracted as follows (business logic removed for clarity):
MigrationServiceBean.java:
@Service (objectName = "vieo.ccs:service=Migration") @Depends({"jboss.jca:service=DataSourceBinding,name=DefaultDS"}) @Management(StartupService.class) public class MigrationServiceBean implements StartupService { @Resource(mappedName="java:/DefaultDS") private DataSource datasource; public void create() throws Exception { } public void destroy() { } public void start() throws Exception { } public void stop() { } }
default-ds.xml:
<?xml version="1.0" encoding="UTF-8"?> <datasources> <local-tx-datasource> <jndi-name>DefaultDS</jndi-name> <connection-url>jdbc:postgresql://localhost:5432/jb5test</connection-url> <driver-class>org.postgresql.Driver</driver-class> <user-name>postgres</user-name> <password>p0stgres</password> <!-- corresponding type-mapping in the standardjbosscmp-jdbc.xml (optional) --> <metadata> <type-mapping>PostgreSQL 8.0</type-mapping> </metadata> <!-- minimum connection pool size --> <min-pool-size>5</min-pool-size> <!-- maximum connection pool size --> <max-pool-size>30</max-pool-size> </local-tx-datasource> </datasources>
The default-ds.xml is deployed separately from the app in the server/all/deploy/ directory. The bean is packaged inside a jar file (StartupService.jar) inside an ear file (vieo-ccs-infrastructure.ear) which is also deployed to the same directory.
The application.xml file for the .ear file is as follows:
<?xml version="1.0" encoding="UTF-8"?> <!DOCTYPE application PUBLIC '-//Sun Microsystems, Inc.//DTD J2EE Application 1.3//EN' 'http://java.sun.com/dtd/application_1_3.dtd'> <application> <display-name>Test app</display-name> <description>Test app</description> <module> <ejb>StartupService.jar</ejb> </module> </application>
This is the error message I get from JBoss:
2008-09-17 12:05:59,495 5328 INFO [org.jboss.web.WebService] (main:) Using RMI server codebase: http://192.168.100.33:8083/
2008-09-17 12:05:59,542 5375 DEBUG [org.jnp.server.NamingBeanImpl] (main:) Using NamingServer: org.jnp.server.NamingServer@10e2558
2008-09-17 12:05:59,542 5375 DEBUG [org.jnp.server.NamingBeanImpl] (main:) Installed global NamingServer: org.jnp.server.NamingServer@10e2558
2008-09-17 12:05:59,557 5390 DEBUG [org.jnp.server.NamingBeanImpl] (main:) InitialContext Environment:
2008-09-17 12:05:59,557 5390 DEBUG [org.jnp.server.NamingBeanImpl] (main:) key=java.naming.factory.initial, value(java.lang.String)=org.jboss.iiop.naming.ORBInitialContextFactory
2008-09-17 12:05:59,557 5390 DEBUG [org.jnp.server.NamingBeanImpl] (main:) key=java.naming.factory.url.pkgs, value(java.lang.String)=org.jboss.naming:org.jnp.interfaces
2008-09-17 12:06:06,620 12453 WARN [org.jboss.system.deployers.HackClassloaderMetaDataDeployer] (main:) FIXME Using loader repository config: jboss.console:sar=console-mgr.sar for vfsfile:/C:/install/jboss-5.0.0.CR1/server/all/deploy/management/console-mgr.sar/ use classloading metadata not loader repository config
2008-09-17 12:06:09,682 15515 INFO [org.jboss.aop.deployers.AspectDeployer] (main:) Deploying xml into org.jboss.aop.AspectManager@1d8e081 for BaseClassLoader@af84e{vfsfile:/C:/install/jboss-5.0.0.CR1/server/all/deploy/ejb3-interceptors-aop.xml}
2008-09-17 12:06:09,745 15578 INFO [org.jboss.aop.deployers.AspectDeployer] (main:) Deploying AOP annotations into org.jboss.aop.AspectManager@1d8e081 for BaseClassLoader@fc644a{vfszip:/C:/install/jboss-5.0.0.CR1/server/all/deploy/cluster/jbossweb-cluster.aop}
2008-09-17 12:06:09,745 15578 INFO [org.jboss.aop.deployers.AspectDeployer] (main:) Deploying xml into org.jboss.aop.AspectManager@1d8e081 for BaseClassLoader@fc644a{vfszip:/C:/install/jboss-5.0.0.CR1/server/all/deploy/cluster/jbossweb-cluster.aop}
2008-09-17 12:06:26,511 32344 INFO [org.jboss.invocation.unified.server.UnifiedInvokerHA] (main:) Service name is jboss:service=invoker,type=unifiedha
2008-09-17 12:06:27,120 32953 INFO [org.jboss.iiop.CorbaNamingService] (main:) CORBA Naming Started
2008-09-17 12:06:30,151 35984 INFO [org.jboss.mx.remoting.service.JMXConnectorServerService] (main:) JMX Connector server: service:jmx:rmi://192.168.100.33/jndi/rmi://192.168.100.33:1090/jmxconnector
2008-09-17 12:06:30,323 36156 INFO [org.jboss.mail.MailService] (main:) Mail Service bound to java:/Mail
2008-09-17 12:06:30,745 36578 INFO [org.jboss.jmx.adaptor.snmp.agent.SnmpAgentService] (main:) SNMP agent going active
2008-09-17 12:06:30,854 36687 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Creating jboss:service=TransactionManager
2008-09-17 12:06:30,854 36687 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Created jboss:service=TransactionManager
2008-09-17 12:06:30,870 36703 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Starting jboss:service=TransactionManager
2008-09-17 12:06:30,870 36703 INFO [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) JBossTS Transaction Service (JTA version) - JBoss Inc.
2008-09-17 12:06:30,870 36703 INFO [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Setting up property manager MBean and JMX layer
2008-09-17 12:06:31,011 36844 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N] (main:) [com.arjuna.ats.arjuna.recovery.TransactionStatusManager_1] - Starting service com.arjuna.ats.arjuna.recovery.ActionStatusService on port 4175
2008-09-17 12:06:31,026 36859 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] (main:) TransactionStatusManagerItem - host: 192.168.100.33 port: 4175
2008-09-17 12:06:31,026 36859 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N] (main:) [com.arjuna.ats.arjuna.recovery.TransactionStatusManager_3] - TransactionStatusManager started on port 4175 with service com.arjuna.ats.arjuna.recovery.ActionStatusService
2008-09-17 12:06:31,057 36890 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] (main:) Registering mbean for module 'arjuna'
2008-09-17 12:06:31,057 36890 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] (main:) Initialising JMX agent com.arjuna.ats.internal.jbossatx.agent.LocalJBossAgentImpl
2008-09-17 12:06:31,057 36890 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] (main:) Registering mbean for module 'jta'
2008-09-17 12:06:31,073 36906 DEBUG [com.arjuna.ats.tsmx.logging.tsmxLogger] (main:) Registering mbean for module 'txoj'
2008-09-17 12:06:31,089 36922 INFO [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Starting recovery manager
2008-09-17 12:06:31,104 36937 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] (main:)
--- Start RecoveryActivators
2008-09-17 12:06:31,120 36953 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] (Thread-18:)
--- ExpiredEntryMonitor ----Wed, 17 Sep 2008 12:06:31----
2008-09-17 12:06:31,261 37094 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] (main:) [com.arjuna.ats.internal.jta.recovery.noxanodes] No XA recovery nodes specified. Will only recover saved states.
2008-09-17 12:06:31,261 37094 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N] (main:) [com.arjuna.ats.internal.arjuna.recovery.ready] RecoveryManagerImple is ready on port 4,179
2008-09-17 12:06:31,261 37094 INFO [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Recovery manager started
2008-09-17 12:06:31,261 37094 INFO [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Binding TransactionManager JNDI Reference
2008-09-17 12:06:31,276 37109 DEBUG [com.arjuna.ats.jbossatx.jta.TransactionManagerService] (main:) Started jboss:service=TransactionManager
2008-09-17 12:06:31,511 37344 INFO [org.apache.catalina.core.AprLifecycleListener] (main:) The Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: c:\install\jdk1.5.0_12\bin;.;C:\WINDOWS\system32;C:\WINDOWS;C:\Program Files\PC Connectivity Solution\;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Intel\DMIX;c:\ant-1.7.0\bin;C:\install\postgres-8.2\bin;C:\install\agntctrl.win_ia32-TPTP-4.4.0.3\bin;C:\Program Files\Common Files\GTK\2.0\bin;C:\Program Files\Subversion;C:\Program Files\TortoiseSVN\bin;
2008-09-17 12:06:31,557 37390 INFO [org.apache.coyote.http11.Http11Protocol] (main:) Initializing Coyote HTTP/1.1 on http-192.168.100.33-8080
2008-09-17 12:06:31,557 37390 INFO [org.apache.coyote.ajp.AjpProtocol] (main:) Initializing Coyote AJP/1.3 on ajp-192.168.100.33-8009
2008-09-17 12:06:31,557 37390 INFO [org.apache.catalina.startup.Catalina] (main:) Initialization processed in 133 ms
2008-09-17 12:06:31,557 37390 INFO [org.apache.catalina.core.StandardService] (main:) Starting service jboss.web
2008-09-17 12:06:31,557 37390 INFO [org.apache.catalina.core.StandardEngine] (main:) Starting Servlet Engine: JBoss Web/2.1.1.CR3
2008-09-17 12:06:31,604 37437 INFO [org.apache.catalina.startup.Catalina] (main:) Server startup in 36 ms
2008-09-17 12:06:32,214 38047 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N] (Thread-18:) [com.arjuna.ats.internal.arjuna.recovery.TransactionStatusConnector_6] - Failed to establish connection to server
2008-09-17 12:06:32,214 38047 DEBUG [com.arjuna.ats.arjuna.logging.arjLoggerI18N] (Thread-18:) [com.arjuna.ats.internal.arjuna.recovery.ExpiredTransactionStatusManagerScanner_3] - Removing old transaction status manager item -3f579bdf:1031:48d081c5:0
2008-09-17 12:06:32,245 38078 INFO [org.jboss.resource.deployers.RARDeployment] (main:) Required license terms exist, view vfszip:/C:/install/jboss-5.0.0.CR1/server/all/deploy/jboss-local-jdbc.rar/META-INF/ra.xml
2008-09-17 12:06:32,245 38078 INFO [org.jboss.resource.deployers.RARDeployment] (main:) Required license terms exist, view vfszip:/C:/install/jboss-5.0.0.CR1/server/all/deploy/jboss-xa-jdbc.rar/META-INF/ra.xml
2008-09-17 12:06:32,276 38109 INFO [org.jboss.resource.deployers.RARDeployment] (main:) Required license terms exist, view vfszip:/C:/install/jboss-5.0.0.CR1/server/all/deploy/jms-ra.rar/META-INF/ra.xml
2008-09-17 12:06:32,276 38109 INFO [org.jboss.resource.deployers.RARDeployment] (main:) Required license terms exist, view vfszip:/C:/install/jboss-5.0.0.CR1/server/all/deploy/mail-ra.rar/META-INF/ra.xml
2008-09-17 12:06:32,307 38140 INFO [org.jboss.resource.deployers.RARDeployment] (main:) Required license terms exist, view vfszip:/C:/install/jboss-5.0.0.CR1/server/all/deploy/quartz-ra.rar/META-INF/ra.xml
2008-09-17 12:06:32,401 38234 INFO [org.quartz.simpl.SimpleThreadPool] (main:) Job execution threads will use class loader of thread: main
2008-09-17 12:06:32,432 38265 INFO [org.quartz.core.QuartzScheduler] (main:) Quartz Scheduler v.1.5.2 created.
2008-09-17 12:06:32,432 38265 INFO [org.quartz.simpl.RAMJobStore] (main:) RAMJobStore initialized.
2008-09-17 12:06:32,448 38281 INFO [org.quartz.impl.StdSchedulerFactory] (main:) Quartz scheduler 'DefaultQuartzScheduler' initialized from default resource file in Quartz package: 'quartz.properties'
2008-09-17 12:06:32,448 38281 INFO [org.quartz.impl.StdSchedulerFactory] (main:) Quartz scheduler version: 1.5.2
2008-09-17 12:06:32,448 38281 INFO [org.quartz.core.QuartzScheduler] (main:) Scheduler DefaultQuartzScheduler_$_NON_CLUSTERED started.
2008-09-17 12:06:32,667 38500 WARN [org.jboss.ejb3.Ejb3AnnotationHandler] (main:) JBMETA-4: did not find any bean meta data for annotation bean MigrationServiceBean, will create some
2008-09-17 12:06:32,729 38562 INFO [STDOUT] (main:) ======> Creating interceptor metadata bridge
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) Created KernelDeployment for: StartupService.jar
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) installing bean: jboss.j2ee:ear=vieo-ccs-infrastructure.ear,jar=StartupService.jar,name=MigrationServiceBean,service=EJB3
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) with dependencies:
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) and demands:
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) jboss.jca:service=DataSourceBinding,name=DefaultDS
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) jboss.ejb:service=EJBTimerService
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) and supplies:
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) Class:com.vieo.ccs.startup.StartupService
2008-09-17 12:06:33,089 38922 INFO [org.jboss.ejb3.deployers.JBossASKernel] (main:) Added bean(jboss.j2ee:ear=vieo-ccs-infrastructure.ear,jar=StartupService.jar,name=MigrationServiceBean,service=EJB3) to KernelDeployment of: StartupService.jar
2008-09-17 12:06:33,182 39015 WARN [org.jboss.wsf.container.jboss50.deployer.WebServiceDeployerEJB] (main:) Ingore ejb deployment with null classname: org.jboss.metadata.ejb.jboss.JBossServiceBeanMetaData@8624c777{MigrationServiceBean}
2008-09-17 12:06:34,245 40078 INFO [org.jboss.ha.framework.interfaces.HAPartition.DefaultPartition] (main:) Initializing partition DefaultPartition
2008-09-17 12:06:34,307 40140 INFO [STDOUT] (JBoss System Threads(1)-3:)
-------------------------------------------------------
GMS: address is 192.168.100.33:7800
-------------------------------------------------------
2008-09-17 12:06:34,370 40203 INFO [STDOUT] (main:)
-------------------------------------------------------
GMS: address is 192.168.100.33:7800
-------------------------------------------------------
2008-09-17 12:06:37,339 43172 INFO [org.jboss.ha.framework.interfaces.HAPartition.DefaultPartition] (JBoss System Threads(1)-3:) Number of cluster members: 1
2008-09-17 12:06:37,339 43172 INFO [org.jboss.ha.framework.interfaces.HAPartition.DefaultPartition] (JBoss System Threads(1)-3:) Other members: 0
2008-09-17 12:06:37,370 43203 INFO [org.jboss.cache.RPCManagerImpl] (main:) Received new cluster view: [192.168.100.33:7800|0] [192.168.100.33:7800]
2008-09-17 12:06:37,401 43234 INFO [org.jboss.cache.RPCManagerImpl] (main:) Cache local address is 192.168.100.33:7800
2008-09-17 12:06:37,432 43265 INFO [org.jboss.cache.CacheImpl.DefaultPartition-HAPartitionCache] (main:) JBoss Cache version: JBossCache 'Alegrias' 2.1.1.GA
2008-09-17 12:06:37,432 43265 INFO [org.jboss.ha.framework.interfaces.HAPartition.DefaultPartition] (main:) Fetching serviceState (will wait for 30000 milliseconds):
2008-09-17 12:06:37,432 43265 INFO [org.jboss.ha.framework.interfaces.HAPartition.DefaultPartition] (main:) State could not be retrieved (we are the first member in group)
2008-09-17 12:06:37,511 43344 INFO [org.jboss.ha.jndi.HANamingService] (main:) Started HAJNDI bootstrap; jnpPort=1100, backlog=50, bindAddress=/192.168.100.33
2008-09-17 12:06:37,979 43812 INFO [org.jboss.wsf.stack.jbws.NativeServerConfig] (main:) JBoss Web Services - Stack Native Core
2008-09-17 12:06:37,979 43812 INFO [org.jboss.wsf.stack.jbws.NativeServerConfig] (main:) 3.0.2.GA
2008-09-17 12:06:38,886 44719 INFO [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main:) deploy, ctxPath=/jbossws, vfsUrl=jbossws.sar/jbossws-management.war
2008-09-17 12:06:39,198 45031 INFO [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main:) deploy, ctxPath=/web-console, vfsUrl=management/console-mgr.sar/web-console.war
2008-09-17 12:06:39,464 45297 INFO [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main:) deploy, ctxPath=/jmx-console, vfsUrl=jmx-console.war
2008-09-17 12:06:39,511 45344 INFO [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main:) deploy, ctxPath=/, vfsUrl=ROOT.war
2008-09-17 12:06:39,542 45375 INFO [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main:) deploy, ctxPath=/invoker, vfsUrl=httpha-invoker.sar/invoker.war
2008-09-17 12:06:39,604 45437 INFO [org.jboss.web.tomcat.service.deployers.TomcatDeployment] (main:) deploy, ctxPath=/juddi, vfsUrl=juddi-service.sar/juddi.war
2008-09-17 12:06:39,682 45515 INFO [org.apache.juddi.registry.RegistryServlet] (main:) Loading jUDDI configuration.
2008-09-17 12:06:39,682 45515 INFO [org.apache.juddi.registry.RegistryServlet] (main:) Resources loaded from: /WEB-INF/juddi.properties
2008-09-17 12:06:39,682 45515 INFO [org.apache.juddi.registry.RegistryServlet] (main:) Initializing jUDDI components.
2008-09-17 12:06:39,776 45609 INFO [org.jboss.resource.connectionmanager.ConnectionFactoryBindingService] (main:) Bound ConnectionManager 'jboss.jca:service=DataSourceBinding,name=DefaultDS' to JNDI name 'java:DefaultDS'
2008-09-17 12:06:40,182 46015 INFO [org.quartz.simpl.SimpleThreadPool] (main:) Job execution threads will use class loader of thread: main
2008-09-17 12:06:40,182 46015 INFO [org.quartz.core.QuartzScheduler] (main:) Quartz Scheduler v.1.5.2 created.
2008-09-17 12:06:40,182 46015 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Using db table-based data access locking (synchronization).
2008-09-17 12:06:40,198 46031 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Removed 0 Volatile Trigger(s).
2008-09-17 12:06:40,198 46031 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Removed 0 Volatile Job(s).
2008-09-17 12:06:40,198 46031 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) JobStoreCMT initialized.
2008-09-17 12:06:40,198 46031 INFO [org.quartz.impl.StdSchedulerFactory] (main:) Quartz scheduler 'JBossEJB3QuartzScheduler' initialized from an externally provided properties instance.
2008-09-17 12:06:40,198 46031 INFO [org.quartz.impl.StdSchedulerFactory] (main:) Quartz scheduler version: 1.5.2
2008-09-17 12:06:40,198 46031 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Freed 0 triggers from 'acquired' / 'blocked' state.
2008-09-17 12:06:40,214 46047 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Recovering 0 jobs that were in-progress at the time of the last shut-down.
2008-09-17 12:06:40,214 46047 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Recovery complete.
2008-09-17 12:06:40,214 46047 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Removed 0 'complete' triggers.
2008-09-17 12:06:40,214 46047 INFO [org.quartz.impl.jdbcjobstore.JobStoreCMT] (main:) Removed 0 stale fired job entries.
2008-09-17 12:06:40,214 46047 INFO [org.quartz.core.QuartzScheduler] (main:) Scheduler JBossEJB3QuartzScheduler_$_NON_CLUSTERED started.
2008-09-17 12:06:40,464 46297 INFO [org.jboss.jms.server.ServerPeer] (main:) JBoss Messaging 1.4.1.CR1 server [1] started
2008-09-17 12:06:40,682 46515 INFO [STDOUT] (main:)
-------------------------------------------------------
GMS: address is 192.168.100.33:7830
-------------------------------------------------------
2008-09-17 12:06:43,683 49516 INFO [org.jboss.messaging.core.impl.postoffice.GroupMember] (main:) org.jboss.messaging.core.impl.postoffice.GroupMember$ControlMembershipListener@e99e got new view [192.168.100.33:7830|0] [192.168.100.33:7830], old view is null
2008-09-17 12:06:43,683 49516 INFO [org.jboss.messaging.core.impl.postoffice.GroupMember] (main:) I am (192.168.100.33:7830)
2008-09-17 12:06:43,683 49516 INFO [org.jboss.messaging.core.impl.postoffice.GroupMember] (main:) New Members : 1 ([192.168.100.33:7830])
2008-09-17 12:06:43,683 49516 INFO [org.jboss.messaging.core.impl.postoffice.GroupMember] (main:) All Members : 1 ([192.168.100.33:7830])
2008-09-17 12:06:43,698 49531 INFO [STDOUT] (main:)
-------------------------------------------------------
GMS: address is 192.168.100.33:7820
-------------------------------------------------------
2008-09-17 12:06:46,808 52641 INFO [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main:) Connector bisocket://192.168.100.33:4457 has leasing enabled, lease period 10000 milliseconds
2008-09-17 12:06:46,808 52641 INFO [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main:) org.jboss.jms.server.connectionfactory.ConnectionFactory@537945 started
2008-09-17 12:06:47,479 53312 INFO [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main:) Connector bisocket://192.168.100.33:4457 has leasing enabled, lease period 10000 milliseconds
2008-09-17 12:06:47,479 53312 INFO [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main:) org.jboss.jms.server.connectionfactory.ConnectionFactory@1d816e0 started
2008-09-17 12:06:47,479 53312 INFO [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main:) Connector bisocket://192.168.100.33:4457 has leasing enabled, lease period 10000 milliseconds
2008-09-17 12:06:47,479 53312 INFO [org.jboss.jms.server.connectionfactory.ConnectionFactory] (main:) org.jboss.jms.server.connectionfactory.ConnectionFactory@1121f65 started
2008-09-17 12:06:47,511 53344 INFO [org.jboss.jms.server.destination.QueueService] (main:) Queue[/queue/DLQ] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2008-09-17 12:06:47,511 53344 INFO [org.jboss.jms.server.destination.QueueService] (main:) Queue[/queue/ExpiryQueue] started, fullSize=200000, pageSize=2000, downCacheSize=2000
2008-09-17 12:06:47,526 53359 INFO [org.jboss.resource.connectionmanager.ConnectionFactoryBindingService] (main:) Bound ConnectionManager 'jboss.jca:service=ConnectionFactoryBinding,name=JmsXA' to JNDI name 'java:JmsXA'
2008-09-17 12:06:47,683 53516 ERROR [org.jboss.system.server.profileservice.ProfileServiceBootstrap] (main:) Failed to load profile: Summary of incomplete deployments (SEE PREVIOUS ERRORS FOR DETAILS):
*** CONTEXTS MISSING DEPENDENCIES: Name -> Dependency{Required State:Actual State}
jboss.j2ee:ear=vieo-ccs-infrastructure.ear,jar=StartupService.jar,name=MigrationServiceBean,service=EJB3
-> <UNKNOWN jboss.j2ee:ear=vieo-ccs-infrastructure.ear,jar=StartupService.jar,name=MigrationServiceBean,service=EJB3>{Described:** UNRESOLVED Demands 'jboss.jca:service=DataSourceBinding,name=DefaultDS' **}
*** CONTEXTS IN ERROR: Name -> Error
<UNKNOWN jboss.j2ee:ear=vieo-ccs-infrastructure.ear,jar=StartupService.jar,name=MigrationServiceBean,service=EJB3> -> ** UNRESOLVED Demands 'jboss.jca:service=DataSourceBinding,name=DefaultDS' **
2008-09-17 12:06:47,683 53516 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] (Thread-19:) Periodic recovery - first pass <Wed, 17 Sep 2008 12:06:47>
2008-09-17 12:06:47,683 53516 DEBUG [com.arjuna.ats.arjuna.logging.arjLogger] (Thread-19:) StatusModule: first pass
2008-09-17 12:06:47,683 53516 DEBUG [com.arjuna.ats.txoj.logging.txojLoggerI18N] (Thread-19:) [com.arjuna.ats.internal.txoj.recovery.TORecoveryModule_3] - TORecoveryModule - first pass
2008-09-17 12:06:47,683 53516 DEBUG [com.arjuna.ats.jta.logging.loggerI18N] (Thread-19:) [com.arjuna.ats.internal.jta.recovery.info.firstpass] Local XARecoveryModule - first pass
2008-09-17 12:06:47,698 53531 INFO [org.apache.coyote.http11.Http11Protocol] (main:) Starting Coyote HTTP/1.1 on http-192.168.100.33-8080
2008-09-17 12:06:47,714 53547 INFO [org.apache.coyote.ajp.AjpProtocol] (main:) Starting Coyote AJP/1.3 on ajp-192.168.100.33-8009
2008-09-17 12:06:47,714 53547 INFO [org.jboss.bootstrap.microcontainer.ServerImpl] (main:) JBoss (Microcontainer) [5.0.0.CR1 (build: SVNTag=JBoss_5_0_0_CR1 date=200806301254)] Started in 53s:532ms
Does anyone have any idea why my MigrationServiceBean fails to deploy?
The crazy thing is that "jboss.jca:service=DataSourceBinding,name=DefaultDS" is listed as started in the jmx-console, and furthermore the other services that are dependent on it (JBM and quartz) are able to create their database schemas just fine!
Am I missing something?