See
http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux/1021/changes
Changes:
[mark.little(a)jboss.com]
http://jira.jboss.com/jira/browse/JBESB-1632
------------------------------------------
[...truncated 10075 lines...]
[java] [junit] 10:20:39,221 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'before-signal' on 'State(wait1)' for 'Token(/)'
[java] [junit] 10:20:39,222 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-leave' on 'State(wait1)' for 'Token(/)'
[java] [junit] 10:20:39,223 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
executing action 'CancelTimerAction(bbbd0e)'
[java] [junit] 10:20:39,223 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is locked by token[1]
[java] [junit] 10:20:39,225 WARN [JbpmJobExector:10.18.0.113:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.job.Timer - this operation breaks ==
[java] [junit] 10:20:39,225 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer timer(wait1,08-07-03 10:20:39,167,Token: 1) by name wait1
[java] [junit] 10:20:39,227 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 10:20:39,228 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'transition' on 'Transition(continue)' for 'Token(/)'
[java] [junit] 10:20:39,229 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-enter' on 'Node(mynode)' for 'Token(/)'
[java] [junit] 10:20:39,231 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-leave' on 'Node(mynode)' for 'Token(/)'
[java] [junit] 10:20:39,231 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'transition' on 'Transition(toWait2)' for 'Token(/)'
[java] [junit] 10:20:39,240 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-enter' on 'State(wait2)' for 'Token(/)'
[java] [junit] 10:20:39,240 WARN [JbpmJobExector:10.18.0.113:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.graph.node.State - this operation breaks ==
[java] [junit] 10:20:39,243 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
executing action 'CreateTimerAction(1e7d503)'
[java] [junit] 10:20:39,243 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is locked by token[1]
[java] [junit] 10:20:39,243 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'timer-create' on 'State(wait2)' for 'Token(/)'
[java] [junit] 10:20:39,244 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 10:20:39,244 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'after-signal' on 'State(wait1)' for 'Token(/)'
[java] [junit] 10:20:39,244 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
executing default save operations
[java] [junit] 10:20:39,244 DEBUG
[JbpmJobExector:10.18.0.113:1][HibernateSaveOperation] saving process instance
[java] [junit] 10:20:39,245 DEBUG
[JbpmJobExector:10.18.0.113:1][SaveLogsOperation] flushing logs to logging service.
[java] [junit] 10:20:39,249 DEBUG
[JbpmJobExector:10.18.0.113:1][CascadeSaveOperation] cascading save of
'org.jbpm.graph.exe.ProcessInstance@19977bd'
[java] [junit] 10:20:39,249 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer(wait1,08-07-03 10:20:39,167,Token: 1)
[java] [junit] 10:20:39,249 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@3c37f4
[java] [junit] 10:20:39,249 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@199f8e6
[java] [junit] 10:20:39,249 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@17d7c7f
[java] [junit] 10:20:39,253 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 10:20:39,253 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@5d3ac0
[java] [junit] 10:20:39,253 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@bc312f
[java] [junit] 10:20:39,253 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'logging': org.jbpm.logging.db.DbLoggingService@14124d6
[java] [junit] 10:20:39,253 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 10:20:39,253 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 10:20:39,253 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@1d978ea
[java] [junit] 10:20:39,253 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 10:20:39,253 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@916f80
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] no acquirable jobs in job table
[java] [junit] 10:20:39,254 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@1d978ea
[java] [junit] 10:20:39,254 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@1bef987
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@916f80
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 10:20:39,254 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@f01d52
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] obtained locks on following jobs: []
[java] [junit] 10:20:39,254 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 10:20:39,254 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@152643
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 10:20:39,254 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 10:20:39,255 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 10:20:39,255 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@8321c8
[java] [junit] 10:20:39,255 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@152643
[java] [junit] 10:20:39,255 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@94aa42
[java] [junit] 10:20:39,256 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@8321c8
[java] [junit] 10:20:39,256 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 10:20:39,256 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@35dc95
[java] [junit] 10:20:40,197 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 10:20:40,197 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@24ea85
[java] [junit] 10:20:40,197 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 10:20:40,197 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 10:20:40,197 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 10:20:40,197 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@1a0d346
[java] [junit] 2 wait2
[java] [junit] 10:20:40,201 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@24ea85
[java] [junit] 10:20:40,201 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@725967
[java] [junit] 10:20:40,201 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@1a0d346
[java] [junit] 10:20:40,202 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 10:20:40,202 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@14492fb
[java] [junit] 10:20:41,204 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 10:20:41,205 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@10dd4c8
[java] [junit] 10:20:41,205 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 10:20:41,205 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 10:20:41,205 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 10:20:41,205 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@10cafa1
[java] [junit] 3 wait2
[java] [junit] 10:20:41,207 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@10dd4c8
[java] [junit] 10:20:41,207 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@329572
[java] [junit] 10:20:41,207 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@10cafa1
[java] [junit] 10:20:41,207 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 10:20:41,208 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@16b98c3
[java] [junit] 10:20:41,244 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 10:20:41,245 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 10:20:41,245 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@fa54fe
[java] [junit] 10:20:41,245 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 10:20:41,245 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 10:20:41,245 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 10:20:41,245 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@e20ef8
[java] [junit] 10:20:41,245 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 10:20:41,246 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] trying to obtain a lock for
'timer(wait2,08-07-03 10:20:41,243,Token: 1)'
[java] [junit] 10:20:41,247 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@fa54fe
[java] [junit] 10:20:41,247 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@870e2f
[java] [junit] 10:20:41,247 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@e20ef8
[java] [junit] 10:20:41,250 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 10:20:41,250 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@ae1393
[java] [junit] 10:20:41,250 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] obtained locks on following jobs:
[timer(wait2,08-07-03 10:20:41,243,Token: 1)]
[java] [junit] 10:20:41,250 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 10:20:41,250 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@871e65
[java] [junit] 10:20:41,250 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 10:20:41,250 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 10:20:41,250 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 10:20:41,250 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@dcb6b4
[java] [junit] 10:20:41,253 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] executing job timer(wait2,08-07-03
10:20:41,243,Token: 1)
[java] [junit] 10:20:41,258 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'before-signal' on 'State(wait2)' for 'Token(/)'
[java] [junit] 10:20:41,259 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-leave' on 'State(wait2)' for 'Token(/)'
[java] [junit] 10:20:41,261 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
executing action 'CancelTimerAction(128594c)'
[java] [junit] 10:20:41,261 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is locked by token[1]
[java] [junit] 10:20:41,268 WARN [JbpmJobExector:10.18.0.113:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.job.Timer - this operation breaks ==
[java] [junit] 10:20:41,268 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer timer(wait2,08-07-03 10:20:41,243,Token: 1) by name wait2
[java] [junit] 10:20:41,270 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 10:20:41,270 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'transition' on 'Transition(continue)' for 'Token(/)'
[java] [junit] 10:20:41,273 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-enter' on 'EndState(end)' for 'Token(/)'
[java] [junit] 10:20:41,274 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'process-end' on 'ProcessDefinition(testTimer)' for
'Token(/)'
[java] [junit] 10:20:41,275 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'after-signal' on 'State(wait2)' for 'Token(/)'
[java] [junit] 10:20:41,276 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
executing default save operations
[java] [junit] 10:20:41,276 DEBUG
[JbpmJobExector:10.18.0.113:1][HibernateSaveOperation] saving process instance
[java] [junit] 10:20:41,276 DEBUG
[JbpmJobExector:10.18.0.113:1][SaveLogsOperation] flushing logs to logging service.
[java] [junit] 10:20:41,279 DEBUG
[JbpmJobExector:10.18.0.113:1][CascadeSaveOperation] cascading save of
'org.jbpm.graph.exe.ProcessInstance@9b777a'
[java] [junit] 10:20:41,279 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer(wait2,08-07-03 10:20:41,243,Token: 1)
[java] [junit] 10:20:41,280 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@871e65
[java] [junit] 10:20:41,280 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@95c5ec
[java] [junit] 10:20:41,280 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@dcb6b4
[java] [junit] 10:20:41,284 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timers for process instance org.jbpm.graph.exe.ProcessInstance@9b777a
[java] [junit] 10:20:41,288 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession] 0
remaining timers for 'org.jbpm.graph.exe.ProcessInstance@9b777a' are deleted
[java] [junit] 10:20:41,288 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting execute-node-jobs for process instance org.jbpm.graph.exe.ProcessInstance@9b777a
[java] [junit] 10:20:41,290 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession] 0
remaining execute-node-jobs for 'org.jbpm.graph.exe.ProcessInstance@9b777a' are
deleted
[java] [junit] 10:20:41,291 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 10:20:41,291 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@83e35b
[java] [junit] 10:20:41,291 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@c378f6
[java] [junit] 10:20:41,291 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'logging': org.jbpm.logging.db.DbLoggingService@13a83cc
[java] [junit] 10:20:41,291 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 10:20:41,291 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 10:20:41,291 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@a2d304
[java] [junit] 10:20:41,291 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 10:20:41,291 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 10:20:41,291 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 10:20:41,291 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@1cbd4f7
[java] [junit] 10:20:41,291 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] no acquirable jobs in job table
[java] [junit] 10:20:41,293 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@a2d304
[java] [junit] 10:20:41,293 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@16aa42e
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@1cbd4f7
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 10:20:41,293 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@40d611
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] obtained locks on following jobs: []
[java] [junit] 10:20:41,293 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 10:20:41,293 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@a632be
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 10:20:41,293 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@14d659d
[java] [junit] 10:20:41,294 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@a632be
[java] [junit] 10:20:41,294 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@343bb6
[java] [junit] 10:20:41,294 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@14d659d
[java] [junit] 10:20:41,294 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 10:20:41,294 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@13c3b45
[java] [junit] 10:20:42,210 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 10:20:42,211 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@15738e0
[java] [junit] 10:20:42,211 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 10:20:42,211 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 10:20:42,211 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 10:20:42,211 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@15726ec
[java] [junit] 4 end
[java] [junit] 10:20:42,213 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@15738e0
[java] [junit] 10:20:42,213 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@1e5cf0
[java] [junit] 10:20:42,213 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@15726ec
[java] [junit] 10:20:42,216 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 10:20:42,216 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@e86614
[java] [junit] ------------- ---------------- ---------------
[java] [junit] Testcase: unknown took 5.13 sec
[java] [junitreport] Transform time: 199ms
[java] [junitreport] Transform time: 75ms
[java] [report] processing input files ...
[java] [report] 1 file(s) read and merged in 4 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 745 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 10 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.258 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.258 sec
[java] [junit] Testcase: warning took 0.004 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 28 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-03 10:20:48 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: 8 minutes 18 seconds
Recording test results
Recording Emma reports trunk/product/build/tests/coverage/coverage.xml