See <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Quickstart... ------------------------------------------ [...truncated 4267 lines...] 07:46:25,940 WARN main [org.jboss.weld.interceptor.util.InterceptionTypeRegistry] Class 'javax.ejb.PrePassivate' not found, interception based on it is not enabled 07:46:26,609 INFO main [org.apache.camel.management.ManagementStrategyFactory] JMX enabled. 07:46:26,636 INFO main [org.switchyard.security.spi.SecurityProvider] Using SecurityProvider implementation: org.switchyard.security.spi.JaasSecurityProvider 07:46:26,643 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-1) is starting 07:46:26,646 INFO main [org.apache.camel.management.DefaultManagementLifecycleStrategy] StatisticsLevel at All so enabling load performance statistics 07:46:27,011 INFO main [org.apache.camel.impl.converter.DefaultTypeConverter] Loaded 185 type converters 07:46:27,064 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Total 0 routes, of which 0 is started. 07:46:27,066 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-1) started in 0.422 seconds Jul 7, 2013 7:46:27 AM org.apache.deltaspike.core.util.ProjectStageProducer initProjectStage INFO: Computed the following DeltaSpike ProjectStage: Production 07:46:27,386 INFO main [org.springframework.transaction.jta.JtaTransactionManager] Using JTA UserTransaction: Transaction: unknown 07:46:27,386 INFO main [org.springframework.transaction.jta.JtaTransactionManager] Using JTA TransactionManager: Transaction: unknown 07:46:27,387 INFO main [org.springframework.transaction.jta.JtaTransactionManager] Using JTA TransactionSynchronizationRegistry: com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionSynchronizationRegistryImple@223dc13d 07:46:28,185 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService/StoreReference started and consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService/StoreReference] 07:46:28,556 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}GreetingService started and consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DGreetingService] 07:46:28,602 INFO main [org.apache.camel.component.jpa.JpaComponent] Using TransactionManager found in registry with id [jtaTransactionManager] org.springframework.transaction.jta.JtaTransactionManager@7b93d2f2 07:46:28,603 WARN main [org.apache.camel.component.jpa.JpaComponent] No EntityManagerFactory has been configured on this JpaComponent. Each JpaEndpoint will auto create their own EntityManagerFactory. 07:46:28,924 INFO main [org.hibernate.annotations.common.Version] HCANN000001: Hibernate Commons Annotations {4.0.1.Final} 07:46:28,936 INFO main [org.hibernate.Version] HHH000412: Hibernate Core {4.2.0.CR1} 07:46:28,939 INFO main [org.hibernate.cfg.Environment] HHH000206: hibernate.properties not found 07:46:28,942 INFO main [org.hibernate.cfg.Environment] HHH000021: Bytecode provider name : javassist 07:46:29,350 INFO main [org.hibernate.dialect.Dialect] HHH000400: Using dialect: org.hibernate.dialect.H2Dialect 07:46:29,368 INFO main [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] HHH000423: Disabling contextual LOB creation as JDBC driver reported JDBC version [3] less than 4 07:46:29,393 INFO main [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jta.CMTTransactionFactory 07:46:29,401 INFO main [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] HHH000397: Using ASTQueryTranslatorFactory 07:46:29,479 INFO main [org.hibernate.validator.internal.util.Version] HV000001: Hibernate Validator 4.3.1.Final 07:46:29,939 INFO main [org.hibernate.tool.hbm2ddl.SchemaExport] HHH000227: Running hbm2ddl schema export 07:46:29,950 INFO main [org.hibernate.tool.hbm2ddl.SchemaExport] HHH000230: Schema export complete 07:46:30,100 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 started and consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:30,365 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService started and consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService] 07:46:30,445 INFO main [org.quartz.simpl.SimpleThreadPool] Job execution threads will use class loader of thread: main 07:46:30,472 INFO main [org.quartz.core.SchedulerSignalerImpl] Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 07:46:30,472 INFO main [org.quartz.core.QuartzScheduler] Quartz Scheduler v.1.8.5 created. 07:46:30,474 INFO main [org.quartz.simpl.RAMJobStore] RAMJobStore initialized. 07:46:30,476 INFO main [org.quartz.core.QuartzScheduler] Scheduler meta-data: Quartz Scheduler (v1.8.5) 'DefaultQuartzScheduler-camel-1' with instanceId 'NON_CLUSTERED' Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. NOT STARTED. Currently in standby mode. Number of jobs executed: 0 Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 10 threads. Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered. 07:46:30,476 INFO main [org.quartz.impl.StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler-camel-1' initialized from an externally provided properties instance. 07:46:30,476 INFO main [org.quartz.impl.StdSchedulerFactory] Quartz scheduler version: 1.8.5 07:46:30,476 INFO main [org.apache.camel.component.quartz.QuartzComponent] Starting Quartz scheduler: DefaultQuartzScheduler-camel-1 07:46:30,476 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-1_$_NON_CLUSTERED started. 07:46:30,561 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 started and consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:30,677 INFO DefaultQuartzScheduler-camel-1_Worker-1 [org.switchyard.quickstarts.camel.jpa.binding.PeriodicServiceImpl] Sending Greet [null, from Tom, to Keith, created on Sun Jul 07 07:46:30 EDT 2013] to JPA store 07:46:30,740 INFO DefaultQuartzScheduler-camel-1_Worker-1 [org.hibernate.dialect.Dialect] HHH000400: Using dialect: org.hibernate.dialect.H2Dialect 07:46:30,742 INFO DefaultQuartzScheduler-camel-1_Worker-1 [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] HHH000423: Disabling contextual LOB creation as JDBC driver reported JDBC version [3] less than 4 07:46:30,743 INFO DefaultQuartzScheduler-camel-1_Worker-1 [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jta.CMTTransactionFactory 07:46:30,744 INFO DefaultQuartzScheduler-camel-1_Worker-1 [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] HHH000397: Using ASTQueryTranslatorFactory 07:46:30,780 INFO DefaultQuartzScheduler-camel-1_Worker-1 [org.hibernate.tool.hbm2ddl.SchemaExport] HHH000227: Running hbm2ddl schema export 07:46:30,789 INFO DefaultQuartzScheduler-camel-1_Worker-1 [org.hibernate.tool.hbm2ddl.SchemaExport] HHH000230: Schema export complete 07:46:30,792 WARN DefaultQuartzScheduler-camel-1_Worker-1 [org.hibernate.ejb.internal.EntityManagerFactoryRegistry] HHH000436: Entity manager factory name (JpaEvents) is already registered. If entity manager will be clustered or passivated, specify a unique value for property 'hibernate.ejb.entitymanager_factory_name' 07:46:30,836 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}StoreReference started and consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DStoreReference] 07:46:30,846 INFO DefaultQuartzScheduler-camel-1_Worker-1 [com.arjuna.ats.arjuna] ARJUNA012163: Starting service com.arjuna.ats.arjuna.recovery.ActionStatusService on port 55800 07:46:30,853 INFO DefaultQuartzScheduler-camel-1_Worker-1 [com.arjuna.ats.arjuna] ARJUNA012337: TransactionStatusManagerItem host: 127.0.0.1 port: 55800 07:46:30,860 INFO DefaultQuartzScheduler-camel-1_Worker-1 [com.arjuna.ats.arjuna] ARJUNA012170: TransactionStatusManager started on port 55800 and host 127.0.0.1 with service com.arjuna.ats.arjuna.recovery.ActionStatusService 07:46:31,188 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Starting to graceful shutdown 1 routes (timeout 300 seconds) 07:46:31,197 INFO Camel (camel-1) thread #2 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Waiting as there are still 1 inflight and pending exchanges to complete, timeout in 300 seconds. 07:46:32,202 INFO Camel (camel-1) thread #2 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 shutdown complete, was consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:32,202 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Graceful shutdown of 1 routes completed in 1 seconds 07:46:32,205 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 stopped, was consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:32,212 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 shutdown and removed, was consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:32,212 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Starting to graceful shutdown 1 routes (timeout 300 seconds) 07:46:32,214 INFO Camel (camel-1) thread #2 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 shutdown complete, was consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:32,214 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Graceful shutdown of 1 routes completed in 0 seconds 07:46:32,215 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 stopped, was consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:32,217 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 shutdown and removed, was consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:32,219 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-1) is shutting down 07:46:32,220 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Starting to graceful shutdown 4 routes (timeout 300 seconds) 07:46:32,220 INFO Camel (camel-1) thread #2 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}StoreReference shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DStoreReference] 07:46:32,221 INFO Camel (camel-1) thread #2 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService] 07:46:32,221 INFO Camel (camel-1) thread #2 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}GreetingService shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DGreetingService] 07:46:32,221 INFO Camel (camel-1) thread #2 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService/StoreReference shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService/StoreReference] 07:46:32,222 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Graceful shutdown of 4 routes completed in 0 seconds 07:46:32,244 INFO main [org.apache.camel.component.quartz.QuartzComponent] There are no more jobs registered, so shutting down Quartz scheduler: DefaultQuartzScheduler-camel-1 07:46:32,244 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-1_$_NON_CLUSTERED shutting down. 07:46:32,244 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-1_$_NON_CLUSTERED paused. 07:46:32,245 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-1_$_NON_CLUSTERED shutdown complete. 07:46:32,246 INFO main [org.apache.camel.impl.converter.DefaultTypeConverter] TypeConverterRegistry utilization[attempts=18, hits=17, misses=1, failures=0] mappings[total=188, misses=0] 07:46:32,252 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-1) is shutdown in 0.032 seconds. Uptime 5.610 seconds. Tests run: 1, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 8.835 sec <<< FAILURE! Running org.switchyard.quickstarts.camel.jpa.binding.CamelJpaBindingReceiveTest 07:46:33,002 INFO main [org.apache.camel.management.ManagementStrategyFactory] JMX enabled. 07:46:33,004 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-2) is starting 07:46:33,004 INFO main [org.apache.camel.management.DefaultManagementLifecycleStrategy] StatisticsLevel at All so enabling load performance statistics 07:46:33,148 INFO main [org.apache.camel.impl.converter.DefaultTypeConverter] Loaded 185 type converters 07:46:33,157 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Total 0 routes, of which 0 is started. 07:46:33,157 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-2) started in 0.154 seconds 07:46:33,268 INFO main [org.springframework.transaction.jta.JtaTransactionManager] Using JTA UserTransaction: Transaction: unknown 07:46:33,268 INFO main [org.springframework.transaction.jta.JtaTransactionManager] Using JTA TransactionManager: Transaction: unknown 07:46:33,269 INFO main [org.springframework.transaction.jta.JtaTransactionManager] Using JTA TransactionSynchronizationRegistry: com.arjuna.ats.internal.jta.transaction.arjunacore.TransactionSynchronizationRegistryImple@63ce50a9 07:46:33,560 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService/StoreReference started and consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService/StoreReference] 07:46:33,814 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}GreetingService started and consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DGreetingService] 07:46:33,839 INFO main [org.apache.camel.component.jpa.JpaComponent] Using TransactionManager found in registry with id [jtaTransactionManager] org.springframework.transaction.jta.JtaTransactionManager@25f5248c 07:46:33,840 WARN main [org.apache.camel.component.jpa.JpaComponent] No EntityManagerFactory has been configured on this JpaComponent. Each JpaEndpoint will auto create their own EntityManagerFactory. 07:46:33,931 INFO main [org.hibernate.dialect.Dialect] HHH000400: Using dialect: org.hibernate.dialect.H2Dialect 07:46:33,932 INFO main [org.hibernate.engine.jdbc.internal.LobCreatorBuilder] HHH000423: Disabling contextual LOB creation as JDBC driver reported JDBC version [3] less than 4 07:46:33,932 INFO main [org.hibernate.engine.transaction.internal.TransactionFactoryInitiator] HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jta.CMTTransactionFactory 07:46:33,933 INFO main [org.hibernate.hql.internal.ast.ASTQueryTranslatorFactory] HHH000397: Using ASTQueryTranslatorFactory 07:46:33,960 INFO main [org.hibernate.tool.hbm2ddl.SchemaExport] HHH000227: Running hbm2ddl schema export 07:46:33,964 INFO main [org.hibernate.tool.hbm2ddl.SchemaExport] HHH000230: Schema export complete 07:46:33,967 WARN main [org.hibernate.ejb.internal.EntityManagerFactoryRegistry] HHH000436: Entity manager factory name (JpaEvents) is already registered. If entity manager will be clustered or passivated, specify a unique value for property 'hibernate.ejb.entitymanager_factory_name' 07:46:33,999 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 started and consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:34,218 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService started and consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService] 07:46:34,241 INFO main [org.quartz.simpl.SimpleThreadPool] Job execution threads will use class loader of thread: main 07:46:34,244 INFO main [org.quartz.core.SchedulerSignalerImpl] Initialized Scheduler Signaller of type: class org.quartz.core.SchedulerSignalerImpl 07:46:34,244 INFO main [org.quartz.core.QuartzScheduler] Quartz Scheduler v.1.8.5 created. 07:46:34,244 INFO main [org.quartz.simpl.RAMJobStore] RAMJobStore initialized. 07:46:34,244 INFO main [org.quartz.core.QuartzScheduler] Scheduler meta-data: Quartz Scheduler (v1.8.5) 'DefaultQuartzScheduler-camel-2' with instanceId 'NON_CLUSTERED' Scheduler class: 'org.quartz.core.QuartzScheduler' - running locally. NOT STARTED. Currently in standby mode. Number of jobs executed: 0 Using thread pool 'org.quartz.simpl.SimpleThreadPool' - with 10 threads. Using job-store 'org.quartz.simpl.RAMJobStore' - which does not support persistence. and is not clustered. 07:46:34,244 INFO main [org.quartz.impl.StdSchedulerFactory] Quartz scheduler 'DefaultQuartzScheduler-camel-2' initialized from an externally provided properties instance. 07:46:34,244 INFO main [org.quartz.impl.StdSchedulerFactory] Quartz scheduler version: 1.8.5 07:46:34,244 INFO main [org.apache.camel.component.quartz.QuartzComponent] Starting Quartz scheduler: DefaultQuartzScheduler-camel-2 07:46:34,244 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-2_$_NON_CLUSTERED started. 07:46:34,306 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 started and consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:35,128 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Starting to graceful shutdown 1 routes (timeout 300 seconds) 07:46:35,131 INFO Camel (camel-2) thread #5 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 shutdown complete, was consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:35,131 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Graceful shutdown of 1 routes completed in 0 seconds 07:46:35,133 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 stopped, was consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:35,137 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelJpaBindingModel/GreetingService@_GreetingService_jpa_1#-816104649 shutdown and removed, was consuming from: Endpoint[jpa://org.switchyard.quickstarts.camel.jpa.binding.domain.Greet?consumeDelete=true&consumeLockEntity=false&consumer.transacted=true&delay=500&initialDelay=1000&persistenceUnit=JpaEvents&transactionManager=%23jtaTransactionManager] 07:46:35,138 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Starting to graceful shutdown 1 routes (timeout 300 seconds) 07:46:35,141 INFO Camel (camel-2) thread #5 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 shutdown complete, was consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:35,141 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Graceful shutdown of 1 routes completed in 0 seconds 07:46:35,142 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 stopped, was consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:35,144 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Route: V1CamelQuartzBindingModel/PeriodicService@_PeriodicService_quartz_1#494946266 shutdown and removed, was consuming from: Endpoint[quartz://EveryFiveSecondsJob?cron=*%2F5+*+*+*+*+%3F] 07:46:35,146 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-2) is shutting down 07:46:35,146 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Starting to graceful shutdown 3 routes (timeout 300 seconds) 07:46:35,147 INFO Camel (camel-2) thread #5 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService] 07:46:35,147 INFO Camel (camel-2) thread #5 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}GreetingService shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DGreetingService] 07:46:35,147 INFO Camel (camel-2) thread #5 - ShutdownTask [org.apache.camel.impl.DefaultShutdownStrategy] Route: direct:{urn:switchyard-quickstart:camel-jpa-binding:0.1.0}PeriodicService/StoreReference shutdown complete, was consuming from: Endpoint[direct://%7Burn:switchyard-quickstart:camel-jpa-binding:0.1.0%7DPeriodicService/StoreReference] 07:46:35,148 INFO main [org.apache.camel.impl.DefaultShutdownStrategy] Graceful shutdown of 3 routes completed in 0 seconds 07:46:35,163 INFO main [org.apache.camel.component.quartz.QuartzComponent] There are no more jobs registered, so shutting down Quartz scheduler: DefaultQuartzScheduler-camel-2 07:46:35,163 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-2_$_NON_CLUSTERED shutting down. 07:46:35,163 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-2_$_NON_CLUSTERED paused. 07:46:35,164 INFO main [org.quartz.core.QuartzScheduler] Scheduler DefaultQuartzScheduler-camel-2_$_NON_CLUSTERED shutdown complete. 07:46:35,165 INFO main [org.apache.camel.impl.converter.DefaultTypeConverter] TypeConverterRegistry utilization[attempts=12, hits=12, misses=0, failures=0] mappings[total=188, misses=0] 07:46:35,169 INFO main [org.switchyard.common.camel.SwitchYardCamelContext] Apache Camel 2.10.0 (CamelContext: camel-2) is shutdown in 0.023 seconds. Uptime 2.166 seconds. Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 2.898 sec Results : Failed tests: storeEntity(org.switchyard.quickstarts.camel.jpa.binding.CamelJpaBindingStoreTest) Tests run: 2, Failures: 1, Errors: 0, Skipped: 0 [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] SwitchYard: Quickstarts ........................... SUCCESS [1.749s] [INFO] Quickstart : Bean Service ......................... SUCCESS [1:03.933s] [INFO] Quickstart : BPEL Service ......................... SUCCESS [0.102s] [INFO] Quickstart : BPEL Service : Say Hello ............. SUCCESS [33.823s] [INFO] Quickstart : BPEL Service : JMS Binding ........... SUCCESS [21.469s] [INFO] Quickstart : BPEL Service : Loan Approval ......... SUCCESS [28.009s] [INFO] Quickstart : BPEL Service : Simple Correlation .... SUCCESS [21.552s] [INFO] Quickstart : BPEL Service : XTS Subordinate WSBA .. SUCCESS [0.035s] [INFO] Quickstart : BPEL Service : XTS Subordinate WSBA : Business Travel Process SUCCESS [2.414s] [INFO] Quickstart : BPEL Service : XTS Subordinate WSBA : Airport Web Service SUCCESS [3.370s] [INFO] Quickstart : BPEL Service : XTS WSAT .............. SUCCESS [0.033s] [INFO] Quickstart : BPEL Service : XTS WSAT : Business Travel Process SUCCESS [1.610s] [INFO] Quickstart : BPEL Service : XTS WSAT : Airport Web Service SUCCESS [2.742s] [INFO] Quickstart : BPM Service .......................... SUCCESS [34.522s] [INFO] Quickstart : Camel Binding ........................ SUCCESS [9.252s] [INFO] Quickstart : Camel JAXB ........................... SUCCESS [13.136s] [INFO] Quickstart : Camel AMQP Binding ................... SUCCESS [14.520s] [INFO] Quickstart : Camel FTP Binding .................... SUCCESS [15.051s] [INFO] Quickstart : Camel JMS Binding .................... SUCCESS [16.688s] [INFO] Quickstart : Camel Netty Binding .................. SUCCESS [23.958s] [INFO] Quickstart : Camel Quartz Binding ................. SUCCESS [10.966s] [INFO] Quickstart : Camel JPA Binding .................... FAILURE [21.554s] [INFO] Quickstart : Camel SQL Binding .................... SKIPPED [INFO] Quickstart : Camel Mail Binding ................... SKIPPED [INFO] Quickstart : Camel Service ........................ SKIPPED [INFO] Quickstart : Camel SOAP Proxy ..................... SKIPPED [INFO] Quickstart : Camel Exchange Bus CDI ............... SKIPPED [INFO] Quickstart : EAR Deployment - Service Artifacts ... SKIPPED [INFO] Quickstart : EAR Deployment - Order Service ....... SKIPPED [INFO] Quickstart : EAR Deployment - Order Consumer ...... SKIPPED [INFO] Quickstart : EAR Deployment - Application Assembly SKIPPED [INFO] Quickstart : EAR Deployment ....................... SKIPPED [INFO] Quickstart : HTTP Binding ......................... SKIPPED [INFO] Quickstart : Remote Invoker ....................... SKIPPED [INFO] Quickstart : RESTEasy Binding ..................... SKIPPED [INFO] Quickstart : Rules+Camel Content-Based Router ..... SKIPPED [INFO] Quickstart : Rules Interview ...................... SKIPPED [INFO] Quickstart : Rules Interview Container ............ SKIPPED [INFO] Quickstart : SOAP with WS-Addressing .............. SKIPPED [INFO] Quickstart : SOAP with Attachments ................ SKIPPED [INFO] Quickstart : SOAP Binding RPC/Lit ................. SKIPPED [INFO] Quickstart : SOAP with MTOM ....................... SKIPPED [INFO] Quickstart : JCA Inflow Binding for HornetQ ....... SKIPPED [INFO] Quickstart : JCA Outbound Binding for HornetQ ..... SKIPPED [INFO] Quickstart : JCA Inflow Binding for ActiveMQ ...... SKIPPED [INFO] Quickstart : JCA Outbound Binding for ActiveMQ .... SKIPPED [INFO] Quickstart : JAXB Transformation .................. SKIPPED [INFO] Quickstart : JSON Transformation .................. SKIPPED [INFO] Quickstart : Smooks Transformation ................ SKIPPED [INFO] Quickstart : XSLT Transformation .................. SKIPPED [INFO] Quickstart : XML Message Validation ............... SKIPPED [INFO] Quickstart Demo : Help Desk ....................... SKIPPED [INFO] Quickstart Demo : Orders .......................... SKIPPED [INFO] Quickstart Demo : JEE Webapp Deployment ........... SKIPPED [INFO] Quickstart Demo: Multiple Applications - Service Artifacts SKIPPED [INFO] Quickstart Demo: Multiple Applications - Order Service SKIPPED [INFO] Quickstart Demo: Multiple Applications - Order Consumer SKIPPED [INFO] Quickstart Demo: Multiple Applications - Web App .. SKIPPED [INFO] Quickstart Demo: Multiple Applications ............ SKIPPED [INFO] Quickstart Demo : Security Policy : Basic Authentication (+SSL) SKIPPED [INFO] Quickstart Demo : Security Policy : Certificate Authentication (+SSL) SKIPPED [INFO] Quickstart Demo : Security Policy : SAML Assertion (+SSL) SKIPPED [INFO] Quickstart Demo : Security Policy : WSS Signature+Encryption (+SSL) SKIPPED [INFO] Quickstart Demo : Security Policy : WSS Username (+SSL) SKIPPED [INFO] Quickstart Demo : Transaction Policy .............. SKIPPED [INFO] Quickstart Demo: Cluster - Client ................. SKIPPED [INFO] Quickstart Demo: Cluster - Credit Service ......... SKIPPED [INFO] Quickstart Demo: Cluster - Dealer Service ......... SKIPPED [INFO] Quickstart Demo: Cluster .......................... SKIPPED [INFO] SwitchYard : Quickstarts Distribution Assembly .... SKIPPED [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 5:46.062s [INFO] Finished at: Sun Jul 07 07:46:35 EDT 2013 [INFO] Final Memory: 158M/568M [INFO] ------------------------------------------------------------------------ [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.6:test (default-test) on project switchyard-quickstart-camel-jpa-binding: There are test failures. [ERROR] [ERROR] Please refer to <http://jenkins.mw.lab.eng.bos.redhat.com/hudson/job/SwitchYard-Quickstart... for the individual test results. [ERROR] -> [Help 1] [ERROR] [ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch. [ERROR] Re-run Maven using the -X switch to enable full debug logging. [ERROR] [ERROR] For more information about the errors and possible solutions, please read the following articles: [ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException [ERROR] [ERROR] After correcting the problems, you can resume the build with the command [ERROR] mvn <goals> -rf :switchyard-quickstart-camel-jpa-binding Build step 'Invoke top-level Maven targets' marked build as failure