6:49 a.m.
See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux/1018/changes
Changes:
[beve] Work for JBESB-1504 "CBR using rules has poor performance"
------------------------------------------
[...truncated 10011 lines...]
[java] [junit] 07:49:29,791 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'before-signal' on 'State(wait1)' for 'Token(/)'
[java] [junit] 07:49:29,791 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'node-leave' on 'State(wait1)' for 'Token(/)'
[java] [junit] 07:49:29,792 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
executing action 'CancelTimerAction(1a9bea3)'
[java] [junit] 07:49:29,792 DEBUG [JbpmJobExector:10.18.1.111:1][Token] token[1]
is locked by token[1]
[java] [junit] 07:49:29,795 WARN [JbpmJobExector:10.18.1.111:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.job.Timer - this operation breaks ==
[java] [junit] 07:49:29,795 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession]
deleting timer timer(wait1,08-07-01 07:49:26,958,Token: 1) by name wait1
[java] [junit] 07:49:29,797 DEBUG [JbpmJobExector:10.18.1.111:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 07:49:29,797 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'transition' on 'Transition(continue)' for 'Token(/)'
[java] [junit] 07:49:29,799 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'node-enter' on 'Node(mynode)' for 'Token(/)'
[java] [junit] 07:49:29,801 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'node-leave' on 'Node(mynode)' for 'Token(/)'
[java] [junit] 07:49:29,801 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'transition' on 'Transition(toWait2)' for 'Token(/)'
[java] [junit] 07:49:29,802 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'node-enter' on 'State(wait2)' for 'Token(/)'
[java] [junit] 07:49:29,803 WARN [JbpmJobExector:10.18.1.111:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.graph.node.State - this operation breaks ==
[java] [junit] 07:49:29,805 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
executing action 'CreateTimerAction(fbcb70)'
[java] [junit] 07:49:29,805 DEBUG [JbpmJobExector:10.18.1.111:1][Token] token[1]
is locked by token[1]
[java] [junit] 07:49:29,805 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'timer-create' on 'State(wait2)' for 'Token(/)'
[java] [junit] 07:49:29,806 DEBUG [JbpmJobExector:10.18.1.111:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 07:49:29,806 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'after-signal' on 'State(wait1)' for 'Token(/)'
[java] [junit] 07:49:29,806 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
executing default save operations
[java] [junit] 07:49:29,806 DEBUG
[JbpmJobExector:10.18.1.111:1][HibernateSaveOperation] saving process instance
[java] [junit] 07:49:29,807 DEBUG
[JbpmJobExector:10.18.1.111:1][SaveLogsOperation] flushing logs to logging service.
[java] [junit] 07:49:29,811 DEBUG
[JbpmJobExector:10.18.1.111:1][CascadeSaveOperation] cascading save of
'org.jbpm.graph.exe.ProcessInstance@25b72a'
[java] [junit] 07:49:29,811 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession]
deleting timer(wait1,08-07-01 07:49:26,958,Token: 1)
[java] [junit] 07:49:29,811 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@537935
[java] [junit] 07:49:29,811 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@ca5bff
[java] [junit] 07:49:29,811 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@3aa791
[java] [junit] 07:49:29,815 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] closing hibernate session
[java] [junit] 07:49:29,815 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'tx': org.jbpm.tx.TxService@150f0a7
[java] [junit] 07:49:29,815 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@e771f3
[java] [junit] 07:49:29,815 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'logging': org.jbpm.logging.db.DbLoggingService@ea3932
[java] [junit] 07:49:29,815 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 07:49:29,815 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 07:49:29,815 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
creating org.jbpm.JbpmContext@15118a7
[java] [junit] 07:49:29,815 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 07:49:29,815 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] creating hibernate session
[java] [junit] 07:49:29,815 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 07:49:29,815 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@1299f7e
[java] [junit] 07:49:29,815 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 07:49:29,816 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] no acquirable jobs in job table
[java] [junit] 07:49:29,816 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@15118a7
[java] [junit] 07:49:29,816 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@53a9d5
[java] [junit] 07:49:29,816 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@1299f7e
[java] [junit] 07:49:29,816 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] closing hibernate session
[java] [junit] 07:49:29,816 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'tx': org.jbpm.tx.TxService@b2e752
[java] [junit] 07:49:29,817 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] obtained locks on following jobs: []
[java] [junit] 07:49:29,817 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 07:49:29,817 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
creating org.jbpm.JbpmContext@170ec24
[java] [junit] 07:49:29,817 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 07:49:29,817 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] creating hibernate session
[java] [junit] 07:49:29,817 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 07:49:29,817 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@9f3e95
[java] [junit] 07:49:29,819 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@170ec24
[java] [junit] 07:49:29,819 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@13c4c09
[java] [junit] 07:49:29,819 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@9f3e95
[java] [junit] 07:49:29,819 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] closing hibernate session
[java] [junit] 07:49:29,819 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'tx': org.jbpm.tx.TxService@1a40247
[java] [junit] 07:49:29,986 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 07:49:29,986 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@91a4fb
[java] [junit] 07:49:29,986 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 07:49:29,986 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 07:49:29,986 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 07:49:29,986 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@1e6978d
[java] [junit] 4 wait2
[java] [junit] 07:49:29,989 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@91a4fb
[java] [junit] 07:49:29,989 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@3c35fd
[java] [junit] 07:49:29,989 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@1e6978d
[java] [junit] 07:49:29,990 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 07:49:29,990 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@1f7abae
[java] [junit] 07:49:30,992 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 07:49:30,992 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@1286b10
[java] [junit] 07:49:30,992 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 07:49:30,992 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 07:49:30,992 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 07:49:30,992 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@8d2280
[java] [junit] 5 wait2
[java] [junit] 07:49:30,994 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@1286b10
[java] [junit] 07:49:30,994 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@41f227
[java] [junit] 07:49:30,994 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@8d2280
[java] [junit] 07:49:30,995 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 07:49:30,995 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@24eafa
[java] [junit] 07:49:31,807 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 07:49:31,807 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 07:49:31,807 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
creating org.jbpm.JbpmContext@1bef987
[java] [junit] 07:49:31,807 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 07:49:31,807 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] creating hibernate session
[java] [junit] 07:49:31,807 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 07:49:31,808 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@f01d52
[java] [junit] 07:49:31,808 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 07:49:31,811 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] trying to obtain a lock for
'timer(wait2,08-07-01 07:49:31,805,Token: 1)'
[java] [junit] 07:49:31,811 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@1bef987
[java] [junit] 07:49:31,811 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@124614c
[java] [junit] 07:49:31,811 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@f01d52
[java] [junit] 07:49:31,812 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] closing hibernate session
[java] [junit] 07:49:31,813 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'tx': org.jbpm.tx.TxService@15e00b7
[java] [junit] 07:49:31,813 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] obtained locks on following jobs:
[timer(wait2,08-07-01 07:49:31,805,Token: 1)]
[java] [junit] 07:49:31,813 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 07:49:31,813 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
creating org.jbpm.JbpmContext@81018b
[java] [junit] 07:49:31,813 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 07:49:31,813 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] creating hibernate session
[java] [junit] 07:49:31,813 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 07:49:31,813 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@18c6cbc
[java] [junit] 07:49:31,815 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] executing job timer(wait2,08-07-01
07:49:31,805,Token: 1)
[java] [junit] 07:49:31,819 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'before-signal' on 'State(wait2)' for 'Token(/)'
[java] [junit] 07:49:31,819 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'node-leave' on 'State(wait2)' for 'Token(/)'
[java] [junit] 07:49:31,820 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
executing action 'CancelTimerAction(f1f34a)'
[java] [junit] 07:49:31,820 DEBUG [JbpmJobExector:10.18.1.111:1][Token] token[1]
is locked by token[1]
[java] [junit] 07:49:31,823 WARN [JbpmJobExector:10.18.1.111:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.job.Timer - this operation breaks ==
[java] [junit] 07:49:31,823 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession]
deleting timer timer(wait2,08-07-01 07:49:31,805,Token: 1) by name wait2
[java] [junit] 07:49:31,823 DEBUG [JbpmJobExector:10.18.1.111:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 07:49:31,823 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'transition' on 'Transition(continue)' for 'Token(/)'
[java] [junit] 07:49:31,825 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'node-enter' on 'EndState(end)' for 'Token(/)'
[java] [junit] 07:49:31,827 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'process-end' on 'ProcessDefinition(testTimer)' for
'Token(/)'
[java] [junit] 07:49:31,828 DEBUG [JbpmJobExector:10.18.1.111:1][GraphElement]
event 'after-signal' on 'State(wait2)' for 'Token(/)'
[java] [junit] 07:49:31,828 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
executing default save operations
[java] [junit] 07:49:31,828 DEBUG
[JbpmJobExector:10.18.1.111:1][HibernateSaveOperation] saving process instance
[java] [junit] 07:49:31,828 DEBUG
[JbpmJobExector:10.18.1.111:1][SaveLogsOperation] flushing logs to logging service.
[java] [junit] 07:49:31,831 DEBUG
[JbpmJobExector:10.18.1.111:1][CascadeSaveOperation] cascading save of
'org.jbpm.graph.exe.ProcessInstance@1de7497'
[java] [junit] 07:49:31,831 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession]
deleting timer(wait2,08-07-01 07:49:31,805,Token: 1)
[java] [junit] 07:49:31,831 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@81018b
[java] [junit] 07:49:31,831 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@e33af5
[java] [junit] 07:49:31,831 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@18c6cbc
[java] [junit] 07:49:31,834 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession]
deleting timers for process instance org.jbpm.graph.exe.ProcessInstance@1de7497
[java] [junit] 07:49:31,838 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession] 0
remaining timers for 'org.jbpm.graph.exe.ProcessInstance@1de7497' are deleted
[java] [junit] 07:49:31,838 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession]
deleting execute-node-jobs for process instance
org.jbpm.graph.exe.ProcessInstance@1de7497
[java] [junit] 07:49:31,840 DEBUG [JbpmJobExector:10.18.1.111:1][JobSession] 0
remaining execute-node-jobs for 'org.jbpm.graph.exe.ProcessInstance@1de7497' are
deleted
[java] [junit] 07:49:31,842 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] closing hibernate session
[java] [junit] 07:49:31,842 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'tx': org.jbpm.tx.TxService@c0890f
[java] [junit] 07:49:31,842 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@666d83
[java] [junit] 07:49:31,842 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'logging': org.jbpm.logging.db.DbLoggingService@9fd062
[java] [junit] 07:49:31,842 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 07:49:31,842 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 07:49:31,842 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
creating org.jbpm.JbpmContext@29f93b
[java] [junit] 07:49:31,842 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 07:49:31,842 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] creating hibernate session
[java] [junit] 07:49:31,842 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 07:49:31,842 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@1a998c7
[java] [junit] 07:49:31,842 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 07:49:31,843 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] no acquirable jobs in job table
[java] [junit] 07:49:31,843 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@29f93b
[java] [junit] 07:49:31,843 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@b28980
[java] [junit] 07:49:31,843 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@1a998c7
[java] [junit] 07:49:31,843 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] closing hibernate session
[java] [junit] 07:49:31,843 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'tx': org.jbpm.tx.TxService@161509b
[java] [junit] 07:49:31,843 DEBUG
[JbpmJobExector:10.18.1.111:1][JobExecutorThread] obtained locks on following jobs: []
[java] [junit] 07:49:31,843 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 07:49:31,843 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
creating org.jbpm.JbpmContext@1f30035
[java] [junit] 07:49:31,844 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 07:49:31,844 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] creating hibernate session
[java] [junit] 07:49:31,844 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 07:49:31,844 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@92af24
[java] [junit] 07:49:31,845 DEBUG [JbpmJobExector:10.18.1.111:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@1f30035
[java] [junit] 07:49:31,845 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@6c9ec6
[java] [junit] 07:49:31,845 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@92af24
[java] [junit] 07:49:31,845 DEBUG
[JbpmJobExector:10.18.1.111:1][DbPersistenceService] closing hibernate session
[java] [junit] 07:49:31,845 DEBUG [JbpmJobExector:10.18.1.111:1][Services]
closing service 'tx': org.jbpm.tx.TxService@12beeec
[java] [junit] 07:49:31,997 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 07:49:31,997 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@152e961
[java] [junit] 07:49:31,997 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 07:49:31,997 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 07:49:31,997 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 07:49:31,998 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@57f57f
[java] [junit] 6 end
[java] [junit] 07:49:32,000 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@152e961
[java] [junit] 07:49:32,000 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@65394b
[java] [junit] 07:49:32,000 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@57f57f
[java] [junit] 07:49:32,000 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 07:49:32,001 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@5c1eae
[java] [junit] ------------- ---------------- ---------------
[java] [junit] Testcase: unknown took 7.116 sec
[java] [junitreport] Transform time: 232ms
[java] [junitreport] Transform time: 87ms
[java] [report] processing input files ...
[java] [report] 1 file(s) read and merged in 6 ms
[java] [report] writing [html] report to
[/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbpm/build/tests/coverage/index.html]
...
[java] test:
[java] test:
[java] [copy] Copying 10 files to
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/tests/classes
[java] prepare:
[java] [mkdir] Created dir:
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/jbrules.esb/META-INF
[java] [mkdir] Created dir:
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/classes
[java] compile:
[java] [javac] Compiling 15 source files to
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/classes
[java] [javac] Note:
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/src/main/java/org/jboss/internal/soa/esb/services/routing/cbr/DslHelper.java
uses or overrides a deprecated API.
[java] [javac] Note: Recompile with -Xlint:deprecation for details.
[java] check.for.files:
[java] jar:
[java] [jar] Building jar:
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/jbossesb-jbrules.jar
[java] esb:
[java] [copy] Copying 17 files to
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/jbrules.esb
[java] base.test:
[java] [mkdir] Created dir:
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/tests/coverage/instr
[java] [instr] processing instrumentation path ...
[java] [instr] instrumentation path processed in 211 ms
[java] [instr] [18 class(es) instrumented, 0 resource(s) copied]
[java] [instr] metadata merged into
[/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/tests/coverage/coverage.emma]
{in 17 ms}
[java] [mkdir] Created dir:
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/tests/report
[java] [javac] Compiling 11 source files to
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/tests/classes
[java] [copy] Copying 3 files to
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build/tests/classes
[java] [echo]
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules
[java] [junit] Running
org.jboss.internal.soa.esb.services.routing.cbr.DslHelperUnitTest
[java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 0.235 sec
[java] [junit] Testsuite:
org.jboss.internal.soa.esb.services.routing.cbr.DslHelperUnitTest
[java] [junit] Tests run: 1, Failures: 1, Errors: 0, Time elapsed: 0.235 sec
[java] [junit] Testcase: warning took 0.003 sec
[java] [junit] FAILED
[java] [junit] No tests found in
org.jboss.internal.soa.esb.services.routing.cbr.DslHelperUnitTest
[java] [junit] junit.framework.AssertionFailedError: No tests found in
org.jboss.internal.soa.esb.services.routing.cbr.DslHelperUnitTest
[java] BUILD FAILED
[java]
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/build.xml:178:
The following error occurred while executing this line:
[java]
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/build.xml:30:
The following error occurred while executing this line:
[java]
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/jbrules/build.xml:16:
The following error occurred while executing this line:
[java]
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/services/base-project-build.xml:104:
Test org.jboss.internal.soa.esb.services.routing.cbr.DslHelperUnitTest failed
[java] Total time: 7 minutes 17 seconds
[java] Java Result: 1
esb.init-app-server:
esb.init-esb-server:
esb.init-ftp-server:
esb.init:
stop-server:
[echo] Stopping local ESB server
[java] Shutdown message has been posted to the server.
[java] Server shutdown may take a while - check logfiles for completion
[echo] 2008-07-01 07:49:35 EDT: waiting for ESB server to stop, checking file
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/build/jbossesb-test/jbossesb-server/server/default/log/server.log
...
BUILD FAILED
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/integration-build.xml:11:
The following error occurred while executing this line:
/qa/services/hudson/hudson_workspace/workspace/jboss-esb-linux/trunk/product/build.xml:488:
Product Unit Test failure
Total time: 7 minutes 53 seconds
Recording test results
Recording Emma reports trunk/product/build/tests/coverage/coverage.xml