8:37 a.m.
See http://hudson.qa.jboss.com/hudson/job/jboss-esb-linux/1020/changes
Changes:
[mark.little(a)jboss.com] http://jira.jboss.com/jira/browse/JBESB-1686
------------------------------------------
[...truncated 10068 lines...]
[java] [junit] 09:37:15,725 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'before-signal' on 'State(wait1)' for 'Token(/)'
[java] [junit] 09:37:15,725 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-leave' on 'State(wait1)' for 'Token(/)'
[java] [junit] 09:37:15,726 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
executing action 'CancelTimerAction(1909385)'
[java] [junit] 09:37:15,726 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is locked by token[1]
[java] [junit] 09:37:15,728 WARN [JbpmJobExector:10.18.0.113:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.job.Timer - this operation breaks ==
[java] [junit] 09:37:15,728 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer timer(wait1,08-07-02 09:37:15,696,Token: 1) by name wait1
[java] [junit] 09:37:15,730 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 09:37:15,730 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'transition' on 'Transition(continue)' for 'Token(/)'
[java] [junit] 09:37:15,732 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-enter' on 'Node(mynode)' for 'Token(/)'
[java] [junit] 09:37:15,734 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-leave' on 'Node(mynode)' for 'Token(/)'
[java] [junit] 09:37:15,734 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'transition' on 'Transition(toWait2)' for 'Token(/)'
[java] [junit] 09:37:15,736 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-enter' on 'State(wait2)' for 'Token(/)'
[java] [junit] 09:37:15,737 WARN [JbpmJobExector:10.18.0.113:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.graph.node.State - this operation breaks ==
[java] [junit] 09:37:15,741 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
executing action 'CreateTimerAction(15b4ad2)'
[java] [junit] 09:37:15,741 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is locked by token[1]
[java] [junit] 09:37:15,741 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'timer-create' on 'State(wait2)' for 'Token(/)'
[java] [junit] 09:37:15,742 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 09:37:15,742 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'after-signal' on 'State(wait1)' for 'Token(/)'
[java] [junit] 09:37:15,742 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
executing default save operations
[java] [junit] 09:37:15,742 DEBUG
[JbpmJobExector:10.18.0.113:1][HibernateSaveOperation] saving process instance
[java] [junit] 09:37:15,743 DEBUG
[JbpmJobExector:10.18.0.113:1][SaveLogsOperation] flushing logs to logging service.
[java] [junit] 09:37:15,747 DEBUG
[JbpmJobExector:10.18.0.113:1][CascadeSaveOperation] cascading save of
'org.jbpm.graph.exe.ProcessInstance@1b5a40a'
[java] [junit] 09:37:15,747 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer(wait1,08-07-02 09:37:15,696,Token: 1)
[java] [junit] 09:37:15,747 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@43153c
[java] [junit] 09:37:15,747 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@1798928
[java] [junit] 09:37:15,747 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@273f4e
[java] [junit] 09:37:15,751 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 09:37:15,752 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@1a5e65f
[java] [junit] 09:37:15,752 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@b79701
[java] [junit] 09:37:15,752 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'logging': org.jbpm.logging.db.DbLoggingService@11adeb7
[java] [junit] 09:37:15,752 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 09:37:15,752 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 09:37:15,752 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@113e8f3
[java] [junit] 09:37:15,752 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 09:37:15,752 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 09:37:15,752 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 09:37:15,752 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@22e177
[java] [junit] 09:37:15,752 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] no acquirable jobs in job table
[java] [junit] 09:37:15,753 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@113e8f3
[java] [junit] 09:37:15,753 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence': org.jbpm.persistence.db.DbPersistenceService@5e9f1
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@22e177
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 09:37:15,753 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@41f227
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] obtained locks on following jobs: []
[java] [junit] 09:37:15,753 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 09:37:15,753 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@1811e2c
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 09:37:15,753 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@1e40274
[java] [junit] 09:37:15,754 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@1811e2c
[java] [junit] 09:37:15,754 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@1d978ea
[java] [junit] 09:37:15,754 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@1e40274
[java] [junit] 09:37:15,754 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 09:37:15,754 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@916f80
[java] [junit] 09:37:16,721 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 09:37:16,721 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@2f4813
[java] [junit] 09:37:16,721 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 09:37:16,721 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 09:37:16,721 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 09:37:16,721 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@24eafa
[java] [junit] 2 wait2
[java] [junit] 09:37:16,726 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@2f4813
[java] [junit] 09:37:16,726 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@16136f0
[java] [junit] 09:37:16,726 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@24eafa
[java] [junit] 09:37:16,726 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 09:37:16,726 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@5c2a25
[java] [junit] 09:37:17,731 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 09:37:17,731 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@d2efa1
[java] [junit] 09:37:17,731 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 09:37:17,731 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 09:37:17,731 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 09:37:17,732 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@725967
[java] [junit] 3 wait2
[java] [junit] 09:37:17,733 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@d2efa1
[java] [junit] 09:37:17,734 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@1e94001
[java] [junit] 09:37:17,734 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@725967
[java] [junit] 09:37:17,734 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 09:37:17,736 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@1b0de2e
[java] [junit] 09:37:17,743 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 09:37:17,743 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 09:37:17,743 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@cad437
[java] [junit] 09:37:17,743 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 09:37:17,743 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 09:37:17,744 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 09:37:17,744 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@329572
[java] [junit] 09:37:17,744 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 09:37:17,759 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] trying to obtain a lock for
'timer(wait2,08-07-02 09:37:17,741,Token: 1)'
[java] [junit] 09:37:17,761 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@cad437
[java] [junit] 09:37:17,761 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@1d1fc02
[java] [junit] 09:37:17,761 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@329572
[java] [junit] 09:37:17,767 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 09:37:17,767 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@f70ee1
[java] [junit] 09:37:17,767 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] obtained locks on following jobs:
[timer(wait2,08-07-02 09:37:17,741,Token: 1)]
[java] [junit] 09:37:17,767 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 09:37:17,767 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@1f1e39b
[java] [junit] 09:37:17,767 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 09:37:17,767 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 09:37:17,768 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 09:37:17,768 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@195ff24
[java] [junit] 09:37:17,773 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] executing job timer(wait2,08-07-02
09:37:17,741,Token: 1)
[java] [junit] 09:37:17,780 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'before-signal' on 'State(wait2)' for 'Token(/)'
[java] [junit] 09:37:17,780 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-leave' on 'State(wait2)' for 'Token(/)'
[java] [junit] 09:37:17,785 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
executing action 'CancelTimerAction(12beeec)'
[java] [junit] 09:37:17,785 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is locked by token[1]
[java] [junit] 09:37:17,793 WARN [JbpmJobExector:10.18.0.113:1][ProxyWarnLog]
Narrowing proxy to class org.jbpm.job.Timer - this operation breaks ==
[java] [junit] 09:37:17,793 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer timer(wait2,08-07-02 09:37:17,741,Token: 1) by name wait2
[java] [junit] 09:37:17,794 DEBUG [JbpmJobExector:10.18.0.113:1][Token] token[1]
is unlocked by token[1]
[java] [junit] 09:37:17,794 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'transition' on 'Transition(continue)' for 'Token(/)'
[java] [junit] 09:37:17,802 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'node-enter' on 'EndState(end)' for 'Token(/)'
[java] [junit] 09:37:17,807 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'process-end' on 'ProcessDefinition(testTimer)' for
'Token(/)'
[java] [junit] 09:37:17,808 DEBUG [JbpmJobExector:10.18.0.113:1][GraphElement]
event 'after-signal' on 'State(wait2)' for 'Token(/)'
[java] [junit] 09:37:17,808 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
executing default save operations
[java] [junit] 09:37:17,808 DEBUG
[JbpmJobExector:10.18.0.113:1][HibernateSaveOperation] saving process instance
[java] [junit] 09:37:17,809 DEBUG
[JbpmJobExector:10.18.0.113:1][SaveLogsOperation] flushing logs to logging service.
[java] [junit] 09:37:17,813 DEBUG
[JbpmJobExector:10.18.0.113:1][CascadeSaveOperation] cascading save of
'org.jbpm.graph.exe.ProcessInstance@11650d6'
[java] [junit] 09:37:17,813 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timer(wait2,08-07-02 09:37:17,741,Token: 1)
[java] [junit] 09:37:17,813 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@1f1e39b
[java] [junit] 09:37:17,813 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@1e26602
[java] [junit] 09:37:17,813 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@195ff24
[java] [junit] 09:37:17,818 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting timers for process instance org.jbpm.graph.exe.ProcessInstance@11650d6
[java] [junit] 09:37:17,823 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession] 0
remaining timers for 'org.jbpm.graph.exe.ProcessInstance@11650d6' are deleted
[java] [junit] 09:37:17,823 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession]
deleting execute-node-jobs for process instance
org.jbpm.graph.exe.ProcessInstance@11650d6
[java] [junit] 09:37:17,824 DEBUG [JbpmJobExector:10.18.0.113:1][JobSession] 0
remaining execute-node-jobs for 'org.jbpm.graph.exe.ProcessInstance@11650d6' are
deleted
[java] [junit] 09:37:17,828 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 09:37:17,828 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@9e75f6
[java] [junit] 09:37:17,828 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'scheduler': org.jbpm.scheduler.db.DbSchedulerService@15291cd
[java] [junit] 09:37:17,828 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'logging': org.jbpm.logging.db.DbLoggingService@1e22c75
[java] [junit] 09:37:17,828 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] acquiring jobs for execution...
[java] [junit] 09:37:17,828 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 09:37:17,828 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@1d4eeb5
[java] [junit] 09:37:17,828 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 09:37:17,828 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 09:37:17,828 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 09:37:17,828 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@83e35b
[java] [junit] 09:37:17,828 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] querying for acquirable job...
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] no acquirable jobs in job table
[java] [junit] 09:37:17,830 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@1d4eeb5
[java] [junit] 09:37:17,830 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@a2d304
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@83e35b
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 09:37:17,830 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@1cbd4f7
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][JobExecutorThread] obtained locks on following jobs: []
[java] [junit] 09:37:17,830 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContextInfo]
creating jbpm context with service factories '[tx, message, scheduler, logging,
persistence, authentication]'
[java] [junit] 09:37:17,830 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
creating org.jbpm.JbpmContext@10ade7e
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceServiceFactory] creating persistence service
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] creating hibernate session
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] beginning hibernate transaction
[java] [junit] 09:37:17,830 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] begun hibernate transaction
org.hibernate.transaction.JDBCTransaction@956254
[java] [junit] 09:37:17,831 DEBUG [JbpmJobExector:10.18.0.113:1][JbpmContext]
closing jbpmContext org.jbpm.JbpmContext@10ade7e
[java] [junit] 09:37:17,831 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'persistence':
org.jbpm.persistence.db.DbPersistenceService@a632be
[java] [junit] 09:37:17,831 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] committing hibernate transaction
org.hibernate.transaction.JDBCTransaction@956254
[java] [junit] 09:37:17,831 DEBUG
[JbpmJobExector:10.18.0.113:1][DbPersistenceService] closing hibernate session
[java] [junit] 09:37:17,831 DEBUG [JbpmJobExector:10.18.0.113:1][Services]
closing service 'tx': org.jbpm.tx.TxService@14d659d
[java] [junit] 09:37:18,738 DEBUG [main][JbpmContextInfo] creating jbpm context
with service factories '[tx, message, scheduler, logging, persistence,
authentication]'
[java] [junit] 09:37:18,739 DEBUG [main][JbpmContext] creating
org.jbpm.JbpmContext@4a3158
[java] [junit] 09:37:18,739 DEBUG [main][DbPersistenceServiceFactory] creating
persistence service
[java] [junit] 09:37:18,739 DEBUG [main][DbPersistenceService] creating hibernate
session
[java] [junit] 09:37:18,739 DEBUG [main][DbPersistenceService] beginning
hibernate transaction
[java] [junit] 09:37:18,739 DEBUG [main][DbPersistenceService] begun hibernate
transaction org.hibernate.transaction.JDBCTransaction@ed8eb5
[java] [junit] 4 end
[java] [junit] 09:37:18,741 DEBUG [main][JbpmContext] closing jbpmContext
org.jbpm.JbpmContext@4a3158
[java] [junit] 09:37:18,741 DEBUG [main][Services] closing service
'persistence': org.jbpm.persistence.db.DbPersistenceService@1a697a1
[java] [junit] 09:37:18,741 DEBUG [main][DbPersistenceService] committing
hibernate transaction org.hibernate.transaction.JDBCTransaction@ed8eb5
[java] [junit] 09:37:18,744 DEBUG [main][DbPersistenceService] closing hibernate
session
[java] [junit] 09:37:18,744 DEBUG [main][Services] closing service 'tx':
org.jbpm.tx.TxService@541b02
[java] [junit] ------------- ---------------- ---------------
[java] [junit] Testcase: unknown took 5.103 sec
[java] [junitreport] Transform time: 192ms
[java] [junitreport] Transform time: 69ms
[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 280 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.295 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.295 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: 8 minutes 3 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-02 09:37:24 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 51 seconds
Recording test results
Recording Emma reports trunk/product/build/tests/coverage/coverage.xml