See <http://hudson.qa.jboss.com/hudson/job/riftsaw-master/32/changes> Changes: [objectiser] RIFTSAW-448 - fix deployment issue where subdeployment created with just a single process, but deployment descriptor still references other processes in the original deployment package [objectiser] RIFTSAW-448 - additional fix to deal with multiple processes being filtered out - need to iterate list in reverse ------------------------------------------ [...truncated 30960 lines...] DEBUG - LoggingInterceptor.print(163) | prepareStatement: select processins0_.ID as col_0_0_ from BPEL_PROCESS_INSTANCE processins0_ where processins0_.PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn889: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_MESSAGE_ROUTE where PROCESS_INSTANCE_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,10) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - ProcessDAOImpl.deleteInstances(147) | Cleaning up process data. DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn890: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select eventdaoim0_.EVENT_ID as col_0_0_ from BPEL_EVENT eventdaoim0_ cross join BPEL_PROCESS_INSTANCE processins1_ where eventdaoim0_.INSTANCE_ID=processins1_.ID and processins1_.PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn891: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select correlatio0_.CORRELATION_SET_ID as col_0_0_ from BPEL_CORRELATION_SET correlatio0_ cross join BPEL_SCOPE scopedaoim1_ cross join BPEL_PROCESS_INSTANCE processins2_ where correlatio0_.SCOPE_ID=scopedaoim1_.SCOPE_ID and scopedaoim1_.PROCESS_INSTANCE_ID=processins2_.ID and processins2_.PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn892: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select messageexc0_.MESSAGE_EXCHANGE_ID as col_0_0_ from BPEL_MESSAGE_EXCHANGE messageexc0_ where messageexc0_.PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn893: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_MESSAGE where MESSAGE_EXCHANGE_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,hqejbhcnphr6mq32g7i4vg) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn894: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_MEX_PROP where MEX_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,hqejbhcnphr6mq32g7i4vg) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn895: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_MESSAGE_EXCHANGE where PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn896: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select distinct xmldatadao0_.XML_DATA_ID as col_0_0_ from BPEL_XML_DATA xmldatadao0_ cross join BPEL_SCOPE scopedaoim1_ cross join BPEL_PROCESS_INSTANCE processins2_ where xmldatadao0_.SCOPE_ID=scopedaoim1_.SCOPE_ID and scopedaoim1_.PROCESS_INSTANCE_ID=processins2_.ID and processins2_.PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn897: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_XML_DATA_PROP where XML_DATA_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,25) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn898: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_XML_DATA_PROP where XML_DATA_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,24) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn899: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select scopedaoim0_.SCOPE_ID as col_0_0_ from BPEL_SCOPE scopedaoim0_ cross join BPEL_PROCESS_INSTANCE processins1_ where scopedaoim0_.PROCESS_INSTANCE_ID=processins1_.ID and processins1_.PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn900: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_XML_DATA where SCOPE_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,15) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn901: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_PARTNER_LINK where SCOPE_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,15) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn902: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_SCOPE where SCOPE_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,15) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn903: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select processins0_.FAULT_ID as col_0_0_ from BPEL_PROCESS_INSTANCE processins0_ where processins0_.PROCESS_ID=? and (processins0_.FAULT_ID is not null) DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn904: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select processins0_.ID as col_0_0_ from BPEL_PROCESS_INSTANCE processins0_ where processins0_.PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn905: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_ACTIVITY_RECOVERY where INSTANCE_ID in (?) DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,10) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn906: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_PROCESS_INSTANCE where PROCESS_ID=? DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn907: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_CORRELATOR where PROC_ID=? DEBUG - LoggingInterceptor.print(163) | executeUpdate, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn908: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: select correlato0_.PROC_ID as PROC3_9_1_, correlato0_.CORRELATOR_ID as CORRELATOR1_1_, correlato0_.CORRELATOR_ID as CORRELATOR1_2_0_, correlato0_.CORRELATOR_KEY as CORRELATOR2_2_0_, correlato0_.PROC_ID as PROC3_2_0_ from BPEL_CORRELATOR correlato0_ where correlato0_.PROC_ID=? DEBUG - LoggingInterceptor.print(163) | executeQuery, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn909: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | prepareStatement: delete from BPEL_PROCESS where ID=? DEBUG - LoggingInterceptor.print(163) | executeBatch, bound (1,13) DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() INFO - BpelServerImpl.deleteProcessDAO(438) | Deleted only the process {http://example.com/loan-approval/}loanApprovalProcess-1. DEBUG - SimpleScheduler.execTransaction(300) | Commiting on org.apache.geronimo.transaction.manager.GeronimoTransactionManager@5e9f1... DEBUG - JpaConnection$1.afterCompletion(77) | -------> clear the entity manager DEBUG - SimpleScheduler.execTransaction(305) | committed on org.apache.geronimo.transaction.manager.GeronimoTransactionManager@5e9f1 successfully. DEBUG - CronScheduler.cancelProcessCronJobs(94) | Cancelling PROCESS CRON jobs for: {http://example.com/loan-approval/}loanApprovalProcess-1 INFO - CronScheduler.cancelProcessCronJobs(116) | Cancelled PROCESS CRON jobs for: {http://example.com/loan-approval/}loanApprovalProcess-1 INFO - ProcessStoreImpl.undeploy(380) | Process {http://example.com/loan-approval/}loanApprovalProcess-1 has been undeployed. DEBUG - BpelServerImpl.stop(224) | BPEL SERVER STOPPING INFO - BpelServerImpl.stop(233) | BPEL Server Stopped. INFO - CoreMessageLogger_$logger.runningHbm2ddlSchemaExport(3504) | HHH00227:Running hbm2ddl schema export DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4to, Connection is: conn910: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() INFO - CoreMessageLogger_$logger.schemaExportComplete(1959) | HHH00230:Schema export complete INFO - CoreMessageLogger_$logger.runningHbm2ddlSchemaExport(3504) | HHH00227:Running hbm2ddl schema export DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4tp, Connection is: conn911: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() INFO - CoreMessageLogger_$logger.schemaExportComplete(1959) | HHH00230:Schema export complete INFO - CoreMessageLogger_$logger.runningHbm2ddlSchemaExport(3504) | HHH00227:Running hbm2ddl schema export DEBUG - LoggingInterceptor.print(163) | getConnection (tx=2) DEBUG - HibernateUtil.getConnection(77) | guid is: hqejbhcnphr6mq32g7i4tq, Connection is: conn912: url=jdbc:h2:mem:jpadb user=SA DEBUG - LoggingInterceptor.print(163) | executeUpdate, w/o params DEBUG - LoggingInterceptor.print(163) | close() DEBUG - LoggingInterceptor.print(163) | close() INFO - CoreMessageLogger_$logger.schemaExportComplete(1959) | HHH00230:Schema export complete DEBUG - Database.shutdown(107) | shutting down database. Tests run: 10, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 30.77 sec <<< FAILURE! Running org.riftsaw.engine.internal.DeploymentManagerTest Tests run: 8, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.085 sec Results : Failed tests: testHelloWorldVersioned(org.riftsaw.engine.BPELEngineTest): Responses differ: file=<?xml version="1.0" encoding="UTF-8"?> <message><TestPart>Hello World2</TestPart></message> message=<?xml version="1.0" encoding="UTF-8"?> <message><TestPart>Hello World</TestPart></message> Tests run: 18, Failures: 1, Errors: 0, Skipped: 0 [INFO] ------------------------------------------------------------------------ [INFO] Reactor Summary: [INFO] [INFO] RiftSaw ........................................... SUCCESS [8.797s] [INFO] Riftsaw::Build .................................... SUCCESS [43.025s] [INFO] RiftSaw::Engine ................................... FAILURE [2:57.265s] [INFO] ------------------------------------------------------------------------ [INFO] BUILD FAILURE [INFO] ------------------------------------------------------------------------ [INFO] Total time: 4:28.164s [INFO] Finished at: Wed Sep 28 10:37:15 EDT 2011 [INFO] Final Memory: 25M/497M [INFO] ------------------------------------------------------------------------ [WARNING] The requested profile "docs" could not be activated because it does not exist. [ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.7.2:test (default-test) on project engine: There are test failures. [ERROR] [ERROR] Please refer to <http://hudson.qa.jboss.com/hudson/job/riftsaw-master/ws/sources/engine/ta... 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 :engine Recording test results