Build: #110 was successful

Job: Cyberintegrator was successful

Stages & jobs

  1. NCSA Common

  2. Cyberintegrator

  3. PAW

  4. Cyberintegrator Webapp

Build log

The build generated 14,751 lines of output.   The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.

25-Feb-2014 01:14:22 01:14:22,030 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:50187     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,030 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:35004         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,030 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:50186     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,030 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:49726         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,031 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:7990          127.0.0.1:48615         FIN_WAIT2 
25-Feb-2014 01:14:22 01:14:22,031 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36958     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,031 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36485     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,031 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8085          127.0.0.1:43711         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,031 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:46257         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,034 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:46249         127.0.0.1:3306          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34990         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:56129         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36075     141.142.227.2:443       CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:45835         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8095          127.0.0.1:51280         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34929         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:39430         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8085          127.0.0.1:43634         FIN_WAIT2 
25-Feb-2014 01:14:22 01:14:22,035 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:36973         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,036 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:57605         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,036 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8095          127.0.0.1:50722         FIN_WAIT2 
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,039 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:59099     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,039 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:50098         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,039 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34951         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8060          127.0.0.1:46209         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36491     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:46252         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:54352         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34955         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34969         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:35859     141.142.227.2:443       CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8095          127.0.0.1:36199         TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,040 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:38404     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,044 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:59100     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,044 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:42532         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,044 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34940         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,044 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:45836         127.0.0.1:3306          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,045 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36486     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,045 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:7990          127.0.0.1:48698         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,045 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34975         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,045 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:58022         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,044 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 01:14:22,045 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8090          127.0.0.1:55970         FIN_WAIT2 
25-Feb-2014 01:14:22 01:14:22,045 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36490     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,046 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8095          127.0.0.1:51495         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,046 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:56416         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:59264     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34948         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34974         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34968         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:8060          127.0.0.1:46405         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:37558         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34965         127.0.0.1:9977          TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:50102         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:41794         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,050 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:50184     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,051 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36169     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,051 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:38313         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:7990          127.0.0.1:48669         TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:59269     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:7990          127.0.0.1:48672         FIN_WAIT2 
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:34368         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:46239         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:9081          127.0.0.1:41230         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:47539         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,055 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:46240         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 Hibernate: select execution0_.id as id230_1_, execution0_.deleted as deleted230_1_, execution0_.creator_id as creator5_238_1_, execution0_.date as date238_1_, execution0_.description as descript2_238_1_, execution0_.title as title238_1_, execution0_.workflowId as workflowId238_1_, person1_.id as id230_0_, person1_.deleted as deleted230_0_, person1_.email as email242_0_, person1_.firstName as firstName242_0_, person1_.lastName as lastName242_0_ from Execution execution0_ left outer join Person person1_ on execution0_.creator_id=person1_.id where execution0_.id=?
25-Feb-2014 01:14:22 01:14:22,056 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:45266         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,056 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:45833         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,056 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:7990          127.0.0.1:48667         TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,055 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 01:14:22,056 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       1      0 127.0.0.1:45425         127.0.0.1:8095          CLOSE_WAIT
25-Feb-2014 01:14:22 Hibernate: select stepstate0_.Execution_id as Execution1_230_0_, stepstate0_.state as state248_0_, stepstate0_.id as id0_ from ExecutionStepState stepstate0_ where stepstate0_.Execution_id=?
25-Feb-2014 01:14:22 01:14:22,057  INFO .cyberintegrator.service.ExecutionsResourceGetTest:  71 - Status of the job:RUNNING
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,060 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6      28      0 141.142.227.2:36221     131.103.28.7:443        CLOSE_WAIT
25-Feb-2014 01:14:22 01:14:22,060 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:7990          127.0.0.1:48727         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,060 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:9081          127.0.0.1:41228         ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,060 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:50118         127.0.0.1:3306          ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,060 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : tcp6       0      0 127.0.0.1:9081          127.0.0.1:40919         TIME_WAIT 
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : udp        0      0 141.142.227.2:36955     141.142.227.11:1514     ESTABLISHED
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : Active UNIX domain sockets (w/o servers)
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : Proto RefCnt Flags       Type       State         I-Node   Path
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    3013     /var/spool/postfix/dev/log
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  5      [ ]         DGRAM                    9637     /queue/ossec/queue
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         DGRAM                    1656     /var/ossec/queue/alerts/execq
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  8      [ ]         DGRAM                    2994     /dev/log
25-Feb-2014 01:14:22 01:14:22,061 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     54695006
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,065 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     54648427
25-Feb-2014 01:14:22 01:14:22,065 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    54314162
25-Feb-2014 01:14:22 01:14:22,065 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    54215675
25-Feb-2014 01:14:22 01:14:22,065 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     48222650
25-Feb-2014 01:14:22 01:14:22,065 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     56943   
25-Feb-2014 01:14:22 01:14:22,065 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     14096   
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     14079   
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     10692   
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     14034   
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     13960   
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     10495   
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    13656   
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9744     
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9743     
25-Feb-2014 01:14:22 01:14:22,066 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9741     
25-Feb-2014 01:14:22 01:14:22,066 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,070 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9740     
25-Feb-2014 01:14:22 01:14:22,070 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9738     
25-Feb-2014 01:14:22 01:14:22,070 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9737     
25-Feb-2014 01:14:22 01:14:22,070 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9735     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9734     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9732     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9731     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9729     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9728     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9726     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9725     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9723     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9722     
25-Feb-2014 01:14:22 01:14:22,071 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9720     
25-Feb-2014 01:14:22 01:14:22,072 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9719     
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,075 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9717     
25-Feb-2014 01:14:22 01:14:22,075 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9716     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9714     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9713     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9711     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9710     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9708     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9707     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9705     
25-Feb-2014 01:14:22 01:14:22,076 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9704     
25-Feb-2014 01:14:22 01:14:22,077 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9702     
25-Feb-2014 01:14:22 01:14:22,077 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9701     
25-Feb-2014 01:14:22 01:14:22,077 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9699     
25-Feb-2014 01:14:22 01:14:22,077 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 01:14:22,077 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9698     
25-Feb-2014 01:14:22 01:14:22,077 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9696     
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,081 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9695     
25-Feb-2014 01:14:22 01:14:22,081 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9693     
25-Feb-2014 01:14:22 01:14:22,082 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9692     
25-Feb-2014 01:14:22 01:14:22,082 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9690     
25-Feb-2014 01:14:22 01:14:22,082 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9689     
25-Feb-2014 01:14:22 01:14:22,082 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9687     
25-Feb-2014 01:14:22 01:14:22,082 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9686     
25-Feb-2014 01:14:22 01:14:22,082 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9684     
25-Feb-2014 01:14:22 01:14:22,083 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9683     
25-Feb-2014 01:14:22 01:14:22,083 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9681     
25-Feb-2014 01:14:22 01:14:22,083 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9680     
25-Feb-2014 01:14:22 01:14:22,083 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9678     
25-Feb-2014 01:14:22 01:14:22,083 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9677     
25-Feb-2014 01:14:22 01:14:22,083 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9675     
25-Feb-2014 01:14:22 01:14:22,083 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9674     
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,087 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9672     
25-Feb-2014 01:14:22 01:14:22,087 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9671     
25-Feb-2014 01:14:22 01:14:22,087 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 01:14:22,088 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9669     
25-Feb-2014 01:14:22 01:14:22,088 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9668     
25-Feb-2014 01:14:22 01:14:22,088 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9666     
25-Feb-2014 01:14:22 01:14:22,088 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9665     
25-Feb-2014 01:14:22 01:14:22,089 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9664     
25-Feb-2014 01:14:22 01:14:22,089 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9663     
25-Feb-2014 01:14:22 01:14:22,089 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9661     
25-Feb-2014 01:14:22 01:14:22,089 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9660     
25-Feb-2014 01:14:22 01:14:22,089 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9659     
25-Feb-2014 01:14:22 01:14:22,089 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9658     
25-Feb-2014 01:14:22 01:14:22,089 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    9639     
25-Feb-2014 01:14:22 01:14:22,090 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    13535   
25-Feb-2014 01:14:22 01:14:22,090 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    1657     
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,094 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    10470   
25-Feb-2014 01:14:22 01:14:22,094 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    13510   
25-Feb-2014 01:14:22 01:14:22,094 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     13483   
25-Feb-2014 01:14:22 01:14:22,094 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     13478   
25-Feb-2014 01:14:22 01:14:22,094 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         STREAM     CONNECTED     13472   
25-Feb-2014 01:14:22 01:14:22,094 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    13022   
25-Feb-2014 01:14:22 01:14:22,094 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  2      [ ]         DGRAM                    12339   
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     8464     @/com/ubuntu/upstart
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     12328   
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     1380     /var/run/dbus/system_bus_socket
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     9400     
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     1355     
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     1354     
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         DGRAM                    1349     
25-Feb-2014 01:14:22 01:14:22,095 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         DGRAM                    1348     
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,098 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,100 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     2878     @/com/ubuntu/upstart
25-Feb-2014 01:14:22 01:14:22,100 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 199 - STDOUT : unix  3      [ ]         STREAM     CONNECTED     8357     
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: update FileDescriptor set deleted=?, dataURL=?, filename=?, md5sum=?, mimetype=?, size=? where id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: select workflowst0_.id as id230_3_, workflowst0_.deleted as deleted230_3_, workflowst0_.createDate as createDate236_3_, workflowst0_.creator_id as creator3_236_3_, workflowst0_.title as title236_3_, workflowst0_.tool_id as tool4_236_3_, person1_.id as id230_0_, person1_.deleted as deleted230_0_, person1_.email as email242_0_, person1_.firstName as firstName242_0_, person1_.lastName as lastName242_0_, workflowto2_.id as id230_1_, workflowto2_.deleted as deleted230_1_, workflowto2_.creator_id as creator7_232_1_, workflowto2_.date as date232_1_, workflowto2_.description as descript2_232_1_, workflowto2_.executor as executor232_1_, workflowto2_.implementation as implemen4_232_1_, workflowto2_.previousVersion_id as previous8_232_1_, workflowto2_.title as title232_1_, workflowto2_.version as version232_1_, person3_.id as id230_2_, person3_.deleted as deleted230_2_, person3_.email as email242_2_, person3_.firstName as firstName242_2_, person3_.lastName as lastName242_2_ from WorkflowStep workflowst0_ left outer join Person person1_ on workflowst0_.creator_id=person1_.id left outer join WorkflowTool workflowto2_ on workflowst0_.tool_id=workflowto2_.id left outer join Person person3_ on workflowto2_.creator_id=person3_.id where workflowst0_.id=?
25-Feb-2014 01:14:22 Hibernate: select execution0_.id as id230_1_, execution0_.deleted as deleted230_1_, execution0_.creator_id as creator5_238_1_, execution0_.date as date238_1_, execution0_.description as descript2_238_1_, execution0_.title as title238_1_, execution0_.workflowId as workflowId238_1_, person1_.id as id230_0_, person1_.deleted as deleted230_0_, person1_.email as email242_0_, person1_.firstName as firstName242_0_, person1_.lastName as lastName242_0_ from Execution execution0_ left outer join Person person1_ on execution0_.creator_id=person1_.id where execution0_.id=?
25-Feb-2014 01:14:22 01:14:22,108 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 Hibernate: select outputs0_.WorkflowTool_id as Workflow1_230_1_, outputs0_.outputs_id as outputs2_259_1_, workflowto1_.id as id230_0_, workflowto1_.deleted as deleted230_0_, workflowto1_.dataid as dataid231_0_, workflowto1_.description as descript2_231_0_, workflowto1_.mimeType as mimeType231_0_, workflowto1_.title as title231_0_ from WorkflowToolOutputs outputs0_ inner join WorkflowToolData workflowto1_ on outputs0_.outputs_id=workflowto1_.id where outputs0_.WorkflowTool_id=?
25-Feb-2014 01:14:22 01:14:22,119 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 01:14:22,129 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: select dataset0_.id as id230_2_, dataset0_.deleted as deleted230_2_, dataset0_.creator_id as creator4_240_2_, dataset0_.date as date240_2_, dataset0_.description as descript2_240_2_, dataset0_.title as title240_2_, contributo1_.Dataset_id as Dataset1_230_4_, person2_.id as contribu2_244_4_, person2_.id as id230_0_, person2_.deleted as deleted230_0_, person2_.email as email242_0_, person2_.firstName as firstName242_0_, person2_.lastName as lastName242_0_, person3_.id as id230_1_, person3_.deleted as deleted230_1_, person3_.email as email242_1_, person3_.firstName as firstName242_1_, person3_.lastName as lastName242_1_ from Dataset dataset0_ left outer join DatasetContributors contributo1_ on dataset0_.id=contributo1_.Dataset_id left outer join Person person2_ on contributo1_.contributors_id=person2_.id left outer join Person person3_ on dataset0_.creator_id=person3_.id where dataset0_.id=?
25-Feb-2014 01:14:22 Hibernate: select outputs0_.WorkflowStep_id as Workflow1_230_0_, outputs0_.outputs as outputs255_0_, outputs0_.outputs_KEY as outputs3_0_ from WorkflowStepOutputs outputs0_ where outputs0_.WorkflowStep_id=?
25-Feb-2014 01:14:22 Hibernate: select datasets0_.Execution_id as Execution1_230_0_, datasets0_.dataset as dataset251_0_, datasets0_.uri as uri0_ from ExecutionDatasets datasets0_ where datasets0_.Execution_id=?
25-Feb-2014 01:14:22 Hibernate: insert into FileDescriptor (deleted, dataURL, filename, md5sum, mimetype, size, id) values (?, ?, ?, ?, ?, ?, ?)
25-Feb-2014 01:14:22 Hibernate: insert into Dataset (deleted, creator_id, date, description, title, id) values (?, ?, ?, ?, ?, ?)
25-Feb-2014 01:14:22 Hibernate: update ExecutionDatasets set dataset=? where Execution_id=? and uri=?
25-Feb-2014 01:14:22 Hibernate: insert into DatasetFileDescriptors (Dataset_id, fileDescriptors_id) values (?, ?)
25-Feb-2014 01:14:22 01:14:22,136 DEBUG         edu.illinois.ncsa.cyberintegrator.Executor: 298 - Job 4afab14c-1209-4f96-8bfd-5cb74710abc6:d4b417f4-eee6-451a-8703-5025fab9dd16 entered FINISHED
25-Feb-2014 01:14:22 Hibernate: select workflowst0_.id as id230_3_, workflowst0_.deleted as deleted230_3_, workflowst0_.createDate as createDate236_3_, workflowst0_.creator_id as creator3_236_3_, workflowst0_.title as title236_3_, workflowst0_.tool_id as tool4_236_3_, person1_.id as id230_0_, person1_.deleted as deleted230_0_, person1_.email as email242_0_, person1_.firstName as firstName242_0_, person1_.lastName as lastName242_0_, workflowto2_.id as id230_1_, workflowto2_.deleted as deleted230_1_, workflowto2_.creator_id as creator7_232_1_, workflowto2_.date as date232_1_, workflowto2_.description as descript2_232_1_, workflowto2_.executor as executor232_1_, workflowto2_.implementation as implemen4_232_1_, workflowto2_.previousVersion_id as previous8_232_1_, workflowto2_.title as title232_1_, workflowto2_.version as version232_1_, person3_.id as id230_2_, person3_.deleted as deleted230_2_, person3_.email as email242_2_, person3_.firstName as firstName242_2_, person3_.lastName as lastName242_2_ from WorkflowStep workflowst0_ left outer join Person person1_ on workflowst0_.creator_id=person1_.id left outer join WorkflowTool workflowto2_ on workflowst0_.tool_id=workflowto2_.id left outer join Person person3_ on workflowto2_.creator_id=person3_.id where workflowst0_.id=?
25-Feb-2014 01:14:22 Hibernate: select execution0_.id as id230_1_, execution0_.deleted as deleted230_1_, execution0_.creator_id as creator5_238_1_, execution0_.date as date238_1_, execution0_.description as descript2_238_1_, execution0_.title as title238_1_, execution0_.workflowId as workflowId238_1_, person1_.id as id230_0_, person1_.deleted as deleted230_0_, person1_.email as email242_0_, person1_.firstName as firstName242_0_, person1_.lastName as lastName242_0_ from Execution execution0_ left outer join Person person1_ on execution0_.creator_id=person1_.id where execution0_.id=?
25-Feb-2014 01:14:22 01:14:22,139 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=1 M=1
25-Feb-2014 01:14:22 Hibernate: select stepstate0_.Execution_id as Execution1_230_0_, stepstate0_.state as state248_0_, stepstate0_.id as id0_ from ExecutionStepState stepstate0_ where stepstate0_.Execution_id=?
25-Feb-2014 01:14:22 Hibernate: select stepsend0_.Execution_id as Execution1_230_0_, stepsend0_.date as date247_0_, stepsend0_.id as id0_ from ExecutionStepEnd stepsend0_ where stepsend0_.Execution_id=?
25-Feb-2014 01:14:22 Hibernate: select outputs0_.WorkflowStep_id as Workflow1_230_0_, outputs0_.outputs as outputs255_0_, outputs0_.outputs_KEY as outputs3_0_ from WorkflowStepOutputs outputs0_ where outputs0_.WorkflowStep_id=?
25-Feb-2014 01:14:22 Hibernate: select datasets0_.Execution_id as Execution1_230_0_, datasets0_.dataset as dataset251_0_, datasets0_.uri as uri0_ from ExecutionDatasets datasets0_ where datasets0_.Execution_id=?
25-Feb-2014 01:14:22 Hibernate: update ExecutionStepState set state=? where Execution_id=? and id=?
25-Feb-2014 01:14:22 Hibernate: update ExecutionStepEnd set date=? where Execution_id=? and id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 Hibernate: select filedescri0_.id as id230_0_, filedescri0_.deleted as deleted230_0_, filedescri0_.dataURL as dataURL239_0_, filedescri0_.filename as filename239_0_, filedescri0_.md5sum as md3_239_0_, filedescri0_.mimetype as mimetype239_0_, filedescri0_.size as size239_0_ from FileDescriptor filedescri0_ where filedescri0_.id=?
25-Feb-2014 01:14:22 01:14:22,150 TRACE           edu.illinois.ncsa.cyberintegrator.Engine: 475 - QS=1 idx=0 X=0 L=1 A=0 M=1
25-Feb-2014 01:14:23 Hibernate: select execution0_.id as id230_1_, execution0_.deleted as deleted230_1_, execution0_.creator_id as creator5_238_1_, execution0_.date as date238_1_, execution0_.description as descript2_238_1_, execution0_.title as title238_1_, execution0_.workflowId as workflowId238_1_, person1_.id as id230_0_, person1_.deleted as deleted230_0_, person1_.email as email242_0_, person1_.firstName as firstName242_0_, person1_.lastName as lastName242_0_ from Execution execution0_ left outer join Person person1_ on execution0_.creator_id=person1_.id where execution0_.id=?
25-Feb-2014 01:14:23 Hibernate: select stepstate0_.Execution_id as Execution1_230_0_, stepstate0_.state as state248_0_, stepstate0_.id as id0_ from ExecutionStepState stepstate0_ where stepstate0_.Execution_id=?
25-Feb-2014 01:14:23 01:14:23,062  INFO .cyberintegrator.service.ExecutionsResourceGetTest:  71 - Status of the job:FINISHED
25-Feb-2014 01:14:23 01:14:23,064  INFO                                                  /:  67 - Closing Spring root WebApplicationContext
25-Feb-2014 01:14:23 01:14:23,065  INFO ework.web.context.support.XmlWebApplicationContext:1025 - Closing Root WebApplicationContext: startup date [Tue Feb 25 01:14:19 CST 2014]; root of context hierarchy
25-Feb-2014 01:14:23 01:14:23,065  INFO k.beans.factory.support.DefaultListableBeanFactory: 433 - Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@118130e9: defining beans [engine,applicationContextProvider,fileStorage,eventBus,entityManagerFactory,transactionManager,dataSource,datasetDAO,fileDescriptorDAO,personDAO,accountDAO,pagingAndSortingAndDeleteRepository,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#0,org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,executionDAO,logFileDAO,workflowToolDAO,workflowToolDataDAO,hPCJobInfoDAO,workflowDAO,workflowToolParameterDAO,workflowStepDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#1]; root of factory hierarchy
25-Feb-2014 01:14:23 01:14:23,069  INFO ork.orm.jpa.LocalContainerEntityManagerFactoryBean: 441 - Closing JPA EntityManagerFactory for persistence unit 'default'
25-Feb-2014 01:14:23 Jetty server stopped
25-Feb-2014 01:14:23 Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 4.08 sec
25-Feb-2014 01:14:23 Running edu.illinois.ncsa.cyberintegrator.service.WorkflowsResourceGetTest
25-Feb-2014 01:14:23 01:14:23,170  INFO a.cyberintegrator.service.WorkflowsResourceGetTest:  31 - Setting up Test for Workflow Resource
25-Feb-2014 01:14:23 01:14:23,171  INFO ramework.beans.factory.xml.XmlBeanDefinitionReader: 315 - Loading XML bean definitions from class path resource [testContext.xml]
25-Feb-2014 01:14:23 01:14:23,242  INFO ework.context.support.GenericXmlApplicationContext: 500 - Refreshing org.springframework.context.support.GenericXmlApplicationContext@6ad57fd9: startup date [Tue Feb 25 01:14:23 CST 2014]; root of context hierarchy
25-Feb-2014 01:14:23 01:14:23,249  INFO gframework.jdbc.datasource.DriverManagerDataSource: 153 - Loaded JDBC driver: org.hsqldb.jdbcDriver
25-Feb-2014 01:14:23 01:14:23,249  INFO ework.context.support.GenericXmlApplicationContext:1355 - Bean 'dataSource' of type [class org.springframework.jdbc.datasource.DriverManagerDataSource] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:23 01:14:23,251  INFO ework.context.support.GenericXmlApplicationContext:1355 - Bean 'org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter#391c5197' of type [class org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:23 01:14:23,296  INFO ork.orm.jpa.LocalContainerEntityManagerFactoryBean: 264 - Building JPA container EntityManagerFactory for persistence unit 'default'
25-Feb-2014 01:14:23 01:14:23,297  INFO                org.hibernate.ejb.Ejb3Configuration: 527 - HHH000204: Processing PersistenceUnitInfo [
25-Feb-2014 01:14:23         name: default
25-Feb-2014 01:14:23         ...]
25-Feb-2014 01:14:23 01:14:23,330  INFO c.connections.internal.ConnectionProviderInitiator: 188 - HHH000130: Instantiating explicit connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
25-Feb-2014 01:14:23 01:14:23,332  INFO                      org.hibernate.dialect.Dialect: 125 - HHH000400: Using dialect: org.hibernate.dialect.HSQLDialect
25-Feb-2014 01:14:23 01:14:23,332  INFO e.transaction.internal.TransactionFactoryInitiator:  73 - HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jdbc.JdbcTransactionFactory
25-Feb-2014 01:14:23 01:14:23,333  INFO bernate.hql.internal.ast.ASTQueryTranslatorFactory:  48 - HHH000397: Using ASTQueryTranslatorFactory
25-Feb-2014 01:14:23 01:14:23,380  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 182 - HHH000228: Running hbm2ddl schema update
25-Feb-2014 01:14:23 01:14:23,380  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 193 - HHH000102: Fetching database metadata
25-Feb-2014 01:14:23 01:14:23,381  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 205 - HHH000396: Updating schema
25-Feb-2014 01:14:23 01:14:23,392  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.ABSTRACTBEAN
25-Feb-2014 01:14:23 01:14:23,392  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, deleted]
25-Feb-2014 01:14:23 01:14:23,392  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:23 01:14:23,392  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10094_10095]
25-Feb-2014 01:14:23 01:14:23,402  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.ACCOUNT
25-Feb-2014 01:14:23 01:14:23,402  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, person_id, userid, password, deleted]
25-Feb-2014 01:14:23 01:14:23,402  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk1d0c220d424b2244]
25-Feb-2014 01:14:23 01:14:23,403  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10098_10099, sys_idx_10231]
25-Feb-2014 01:14:23 01:14:23,413  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASET
25-Feb-2014 01:14:23 01:14:23,413  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, description, date, deleted, creator_id]
25-Feb-2014 01:14:23 01:14:23,413  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkb93e4c5861a77a0d]
25-Feb-2014 01:14:23 01:14:23,413  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10102_10103, sys_idx_10233]
25-Feb-2014 01:14:23 01:14:23,423  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASETCONTRIBUTORS
25-Feb-2014 01:14:23 01:14:23,423  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, dataset_id]
25-Feb-2014 01:14:23 01:14:23,423  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkb059770defc2750, fkb0597702f8cbbc1]
25-Feb-2014 01:14:23 01:14:23,424  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10235, sys_idx_10237, sys_idx_sys_ct_10106_10108]
25-Feb-2014 01:14:23 01:14:23,433  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASETFILEDESCRIPTORS
25-Feb-2014 01:14:23 01:14:23,434  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [filedescriptors_id, dataset_id]
25-Feb-2014 01:14:23 01:14:23,434  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk95f77850cdcd8587, fk95f77850defc2750]
25-Feb-2014 01:14:23 01:14:23,434  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10239, sys_idx_10241]
25-Feb-2014 01:14:23 01:14:23,444  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTION
25-Feb-2014 01:14:23 01:14:23,445  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, description, date, workflowid, deleted, creator_id]
25-Feb-2014 01:14:23 01:14:23,445  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk366b2af861a77a0d]
25-Feb-2014 01:14:23 01:14:23,445  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10114_10115, sys_idx_10243]
25-Feb-2014 01:14:23 01:14:23,455  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONDATASETS
25-Feb-2014 01:14:23 01:14:23,455  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [dataset, execution_id, uri]
25-Feb-2014 01:14:23 01:14:23,456  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fke677f21387f7d04e]
25-Feb-2014 01:14:23 01:14:23,456  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10245, sys_idx_sys_pk_10118_10119]
25-Feb-2014 01:14:23 01:14:23,466  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONPARAMETERS
25-Feb-2014 01:14:23 01:14:23,466  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [parameter, execution_id, uri]
25-Feb-2014 01:14:23 01:14:23,466  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkc1b5730287f7d04e]
25-Feb-2014 01:14:23 01:14:23,466  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10247, sys_idx_sys_pk_10122_10123]
25-Feb-2014 01:14:23 01:14:23,476  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONPROPERTIES
25-Feb-2014 01:14:23 01:14:23,476  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [pkey, pvalue, execution_id]
25-Feb-2014 01:14:23 01:14:23,477  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk6f2b3e4b87f7d04e]
25-Feb-2014 01:14:23 01:14:23,477  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10126_10127, sys_idx_10249]
25-Feb-2014 01:14:23 01:14:23,487  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPEND
25-Feb-2014 01:14:23 01:14:23,487  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:23 01:14:23,487  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk510fac5787f7d04e]
25-Feb-2014 01:14:23 01:14:23,488  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10251, sys_idx_sys_pk_10130_10131]
25-Feb-2014 01:14:23 01:14:23,497  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPQUEUED
25-Feb-2014 01:14:23 01:14:23,498  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:23 01:14:23,498  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk43c7647787f7d04e]
25-Feb-2014 01:14:23 01:14:23,498  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10134_10135, sys_idx_10253]
25-Feb-2014 01:14:23 01:14:23,508  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPSTART
25-Feb-2014 01:14:23 01:14:23,508  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:23 01:14:23,509  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk4c9df8de87f7d04e]
25-Feb-2014 01:14:23 01:14:23,509  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10255, sys_idx_sys_pk_10138_10139]
25-Feb-2014 01:14:23 01:14:23,519  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPSTATE
25-Feb-2014 01:14:23 01:14:23,520  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, state, execution_id]
25-Feb-2014 01:14:23 01:14:23,520  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk4c9df90d87f7d04e]
25-Feb-2014 01:14:23 01:14:23,520  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10257, sys_idx_sys_pk_10142_10143]
25-Feb-2014 01:14:23 01:14:23,531  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.FILEDESCRIPTOR
25-Feb-2014 01:14:23 01:14:23,531  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [md5sum, id, mimetype, dataurl, filename, deleted, size]
25-Feb-2014 01:14:23 01:14:23,531  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:23 01:14:23,531  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10147_10148]
25-Feb-2014 01:14:23 01:14:23,541  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.HPCJOBINFO
25-Feb-2014 01:14:23 01:14:23,541  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, standardoutput, workingdir, standarderror, executionid, deleted, jobid]
25-Feb-2014 01:14:23 01:14:23,542  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:23 01:14:23,542  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10151_10152]
25-Feb-2014 01:14:23 01:14:23,552  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.LOGFILE
25-Feb-2014 01:14:23 01:14:23,552  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, executionid, stepid, date, deleted, log_id]
25-Feb-2014 01:14:23 01:14:23,552  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk779062c0626974ab]
25-Feb-2014 01:14:23 01:14:23,553  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10259, sys_idx_sys_pk_10155_10156]
25-Feb-2014 01:14:23 01:14:23,582  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.PERSON
25-Feb-2014 01:14:23 01:14:23,583  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, email, lastname, firstname, deleted]
25-Feb-2014 01:14:23 01:14:23,583  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:23 01:14:23,583  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10159_10160]
25-Feb-2014 01:14:23 01:14:23,592  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.TOOLBLOBS
25-Feb-2014 01:14:23 01:14:23,592  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, blobs_id]
25-Feb-2014 01:14:23 01:14:23,592  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk5d0ac99e7c2a6e39, fk5d0ac99ed5bfd466]
25-Feb-2014 01:14:23 01:14:23,592  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10163_10165, sys_idx_sys_ct_10164_10166, sys_idx_10261, sys_idx_10263]
25-Feb-2014 01:14:23 01:14:23,600  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOW
25-Feb-2014 01:14:23 01:14:23,601  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, created, description, deleted, creator_id]
25-Feb-2014 01:14:23 01:14:23,601  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk5f63bdf61a77a0d]
25-Feb-2014 01:14:23 01:14:23,601  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10169_10170, sys_idx_10265]
25-Feb-2014 01:14:23 01:14:23,609  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWCONTRIBUTORS
25-Feb-2014 01:14:23 01:14:23,609  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, workflow_id]
25-Feb-2014 01:14:23 01:14:23,610  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk176774772f8cbbc1, fk17677477cbde8d46]
25-Feb-2014 01:14:23 01:14:23,610  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10267, sys_idx_10269, sys_idx_sys_ct_10173_10175]
25-Feb-2014 01:14:23 01:14:23,618  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEP
25-Feb-2014 01:14:23 01:14:23,618  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, createdate, tool_id, deleted, creator_id]
25-Feb-2014 01:14:23 01:14:23,618  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk66ceaf4b61a77a0d, fk66ceaf4bbe8b1105]
25-Feb-2014 01:14:23 01:14:23,618  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10178_10179, sys_idx_10271, sys_idx_10273]
25-Feb-2014 01:14:23 01:14:23,626  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPINPUTS
25-Feb-2014 01:14:23 01:14:23,627  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [inputs, inputs_key, workflowstep_id]
25-Feb-2014 01:14:23 01:14:23,627  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkf9175914a8d657e6]
25-Feb-2014 01:14:23 01:14:23,627  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10275, sys_idx_sys_pk_10181_10182]
25-Feb-2014 01:14:23 01:14:23,635  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPOUTPUTS
25-Feb-2014 01:14:23 01:14:23,635  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [outputs_key, outputs, workflowstep_id]
25-Feb-2014 01:14:23 01:14:23,635  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk736135c7a8d657e6]
25-Feb-2014 01:14:23 01:14:23,636  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10184_10185, sys_idx_10277]
25-Feb-2014 01:14:23 01:14:23,643  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPPARAMETERS
25-Feb-2014 01:14:23 01:14:23,643  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [parameters_key, parameters, workflowstep_id]
25-Feb-2014 01:14:23 01:14:23,644  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk44a9eb95a8d657e6]
25-Feb-2014 01:14:23 01:14:23,644  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10187_10188, sys_idx_10279]
25-Feb-2014 01:14:23 01:14:23,652  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPS
25-Feb-2014 01:14:23 01:14:23,652  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflow_id, steps_id]
25-Feb-2014 01:14:23 01:14:23,652  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk73073a88cbde8d46, fk73073a8857b2a64a]
25-Feb-2014 01:14:23 01:14:23,652  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10283, sys_idx_10281, sys_idx_sys_ct_10191_10193]
25-Feb-2014 01:14:23 01:14:23,661  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOL
25-Feb-2014 01:14:23 01:14:23,661  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, previousversion_id, implementation, description, executor, date, deleted, creator_id, version]
25-Feb-2014 01:14:23 01:14:23,661  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk66cf121761a77a0d, fk66cf1217a56447fc]
25-Feb-2014 01:14:23 01:14:23,661  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10287, sys_idx_10285, sys_idx_sys_pk_10196_10197]
25-Feb-2014 01:14:23 01:14:23,670  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLCONTRIBUTORS
25-Feb-2014 01:14:23 01:14:23,670  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, workflowtool_id]
25-Feb-2014 01:14:23 01:14:23,670  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fka858b6af2f8cbbc1, fka858b6afd5bfd466]
25-Feb-2014 01:14:23 01:14:23,670  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10200_10202, sys_idx_10289, sys_idx_sys_ct_10201_10203, sys_idx_10291]
25-Feb-2014 01:14:23 01:14:23,679  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLDATA
25-Feb-2014 01:14:23 01:14:23,679  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, mimetype, description, dataid, deleted]
25-Feb-2014 01:14:23 01:14:23,679  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:23 01:14:23,679  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10206_10207]
25-Feb-2014 01:14:23 01:14:23,688  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLINPUTS
25-Feb-2014 01:14:23 01:14:23,688  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, inputs_id]
25-Feb-2014 01:14:23 01:14:23,688  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk433d72e0d5bfd466, fk433d72e0fc8b655e]
25-Feb-2014 01:14:23 01:14:23,688  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10293, sys_idx_10295, sys_idx_sys_ct_10210_10212]
25-Feb-2014 01:14:23 01:14:23,696  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLOUTPUTS
25-Feb-2014 01:14:23 01:14:23,696  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, outputs_id]
25-Feb-2014 01:14:23 01:14:23,696  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk6dfe557bd5bfd466, fk6dfe557b4adfb315]
25-Feb-2014 01:14:23 01:14:23,697  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10297, sys_idx_sys_ct_10215_10217, sys_idx_10299]
25-Feb-2014 01:14:23 01:14:23,704  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETER
25-Feb-2014 01:14:23 01:14:23,704  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, paramid, hidden, description, value, type, allownull, deleted]
25-Feb-2014 01:14:23 01:14:23,705  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:23 01:14:23,705  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10222_10223]
25-Feb-2014 01:14:23 01:14:23,713  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETER_OPTIONS
25-Feb-2014 01:14:23 01:14:23,713  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtoolparameter_id, options]
25-Feb-2014 01:14:23 01:14:23,714  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk1a35e6b18f0763ce]
25-Feb-2014 01:14:23 01:14:23,714  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10301]
25-Feb-2014 01:14:23 01:14:23,722  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETERS
25-Feb-2014 01:14:23 01:14:23,722  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, parameters_id]
25-Feb-2014 01:14:23 01:14:23,722  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk77563f61d5bfd466, fk77563f61d511e296]
25-Feb-2014 01:14:23 01:14:23,722  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10305, sys_idx_10303, sys_idx_sys_ct_10228_10230]
25-Feb-2014 01:14:23 01:14:23,723  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 240 - HHH000232: Schema update complete
25-Feb-2014 01:14:23 01:14:23,733  WARN ibernate.ejb.internal.EntityManagerFactoryRegistry:  80 - HHH000436: Entity manager factory name (default) is already registered.  If entity manager will be clustered or passivated, specify a unique value for property 'hibernate.ejb.entitymanager_factory_name'
25-Feb-2014 01:14:23 01:14:23,733  INFO ework.context.support.GenericXmlApplicationContext:1355 - Bean 'entityManagerFactory' of type [class org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:23 01:14:23,735  INFO k.beans.factory.support.DefaultListableBeanFactory: 581 - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4b494996: defining beans [engine,applicationContextProvider,fileStorage,eventBus,entityManagerFactory,transactionManager,dataSource,pagingAndSortingAndDeleteRepository,personDAO,datasetDAO,accountDAO,fileDescriptorDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#0,org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,executionDAO,workflowToolParameterDAO,workflowToolDAO,workflowDAO,logFileDAO,workflowToolDataDAO,workflowStepDAO,hPCJobInfoDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#1]; root of factory hierarchy
25-Feb-2014 01:14:23 01:14:23,736  INFO           edu.illinois.ncsa.cyberintegrator.Engine: 200 - Adding executor : java
25-Feb-2014 01:14:23 01:14:23,736  INFO           edu.illinois.ncsa.cyberintegrator.Engine: 200 - Adding executor : commandline
25-Feb-2014 01:14:23 Hibernate: select workflow0_.id as id276_2_, workflow0_.deleted as deleted276_2_, workflow0_.created as created283_2_, workflow0_.creator_id as creator4_283_2_, workflow0_.description as descript2_283_2_, workflow0_.title as title283_2_, contributo1_.Workflow_id as Workflow1_276_4_, person2_.id as contribu2_299_4_, person2_.id as id276_0_, person2_.deleted as deleted276_0_, person2_.email as email288_0_, person2_.firstName as firstName288_0_, person2_.lastName as lastName288_0_, person3_.id as id276_1_, person3_.deleted as deleted276_1_, person3_.email as email288_1_, person3_.firstName as firstName288_1_, person3_.lastName as lastName288_1_ from Workflow workflow0_ left outer join WorkflowContributors contributo1_ on workflow0_.id=contributo1_.Workflow_id left outer join Person person2_ on contributo1_.contributors_id=person2_.id left outer join Person person3_ on workflow0_.creator_id=person3_.id where workflow0_.id=?
25-Feb-2014 01:14:23 Hibernate: select person0_.id as id276_0_, person0_.deleted as deleted276_0_, person0_.email as email288_0_, person0_.firstName as firstName288_0_, person0_.lastName as lastName288_0_ from Person person0_ where person0_.id=?
25-Feb-2014 01:14:23 Hibernate: select workflowst0_.id as id276_5_, workflowst0_.deleted as deleted276_5_, workflowst0_.createDate as createDate282_5_, workflowst0_.creator_id as creator3_282_5_, workflowst0_.title as title282_5_, workflowst0_.tool_id as tool4_282_5_, person1_.id as id276_0_, person1_.deleted as deleted276_0_, person1_.email as email288_0_, person1_.firstName as firstName288_0_, person1_.lastName as lastName288_0_, workflowto2_.id as id276_1_, workflowto2_.deleted as deleted276_1_, workflowto2_.creator_id as creator7_278_1_, workflowto2_.date as date278_1_, workflowto2_.description as descript2_278_1_, workflowto2_.executor as executor278_1_, workflowto2_.implementation as implemen4_278_1_, workflowto2_.previousVersion_id as previous8_278_1_, workflowto2_.title as title278_1_, workflowto2_.version as version278_1_, blobs3_.WorkflowTool_id as Workflow1_276_7_, filedescri4_.id as blobs2_308_7_, filedescri4_.id as id276_2_, filedescri4_.deleted as deleted276_2_, filedescri4_.dataURL as dataURL285_2_, filedescri4_.filename as filename285_2_, filedescri4_.md5sum as md3_285_2_, filedescri4_.mimetype as mimetype285_2_, filedescri4_.size as size285_2_, person5_.id as id276_3_, person5_.deleted as deleted276_3_, person5_.email as email288_3_, person5_.firstName as firstName288_3_, person5_.lastName as lastName288_3_, workflowto6_.id as id276_4_, workflowto6_.deleted as deleted276_4_, workflowto6_.creator_id as creator7_278_4_, workflowto6_.date as date278_4_, workflowto6_.description as descript2_278_4_, workflowto6_.executor as executor278_4_, workflowto6_.implementation as implemen4_278_4_, workflowto6_.previousVersion_id as previous8_278_4_, workflowto6_.title as title278_4_, workflowto6_.version as version278_4_ from WorkflowStep workflowst0_ left outer join Person person1_ on workflowst0_.creator_id=person1_.id left outer join WorkflowTool workflowto2_ on workflowst0_.tool_id=workflowto2_.id left outer join ToolBlobs blobs3_ on workflowto2_.id=blobs3_.WorkflowTool_id left outer join FileDescriptor filedescri4_ on blobs3_.blobs_id=filedescri4_.id left outer join Person person5_ on workflowto2_.creator_id=person5_.id left outer join WorkflowTool workflowto6_ on workflowto2_.previousVersion_id=workflowto6_.id where workflowst0_.id=?
25-Feb-2014 01:14:23 Hibernate: select workflowto0_.id as id276_3_, workflowto0_.deleted as deleted276_3_, workflowto0_.creator_id as creator7_278_3_, workflowto0_.date as date278_3_, workflowto0_.description as descript2_278_3_, workflowto0_.executor as executor278_3_, workflowto0_.implementation as implemen4_278_3_, workflowto0_.previousVersion_id as previous8_278_3_, workflowto0_.title as title278_3_, workflowto0_.version as version278_3_, blobs1_.WorkflowTool_id as Workflow1_276_5_, filedescri2_.id as blobs2_308_5_, filedescri2_.id as id276_0_, filedescri2_.deleted as deleted276_0_, filedescri2_.dataURL as dataURL285_0_, filedescri2_.filename as filename285_0_, filedescri2_.md5sum as md3_285_0_, filedescri2_.mimetype as mimetype285_0_, filedescri2_.size as size285_0_, person3_.id as id276_1_, person3_.deleted as deleted276_1_, person3_.email as email288_1_, person3_.firstName as firstName288_1_, person3_.lastName as lastName288_1_, workflowto4_.id as id276_2_, workflowto4_.deleted as deleted276_2_, workflowto4_.creator_id as creator7_278_2_, workflowto4_.date as date278_2_, workflowto4_.description as descript2_278_2_, workflowto4_.executor as executor278_2_, workflowto4_.implementation as implemen4_278_2_, workflowto4_.previousVersion_id as previous8_278_2_, workflowto4_.title as title278_2_, workflowto4_.version as version278_2_ from WorkflowTool workflowto0_ left outer join ToolBlobs blobs1_ on workflowto0_.id=blobs1_.WorkflowTool_id left outer join FileDescriptor filedescri2_ on blobs1_.blobs_id=filedescri2_.id left outer join Person person3_ on workflowto0_.creator_id=person3_.id left outer join WorkflowTool workflowto4_ on workflowto0_.previousVersion_id=workflowto4_.id where workflowto0_.id=?
25-Feb-2014 01:14:23 Hibernate: select workflowto0_.id as id276_0_, workflowto0_.deleted as deleted276_0_, workflowto0_.dataid as dataid277_0_, workflowto0_.description as descript2_277_0_, workflowto0_.mimeType as mimeType277_0_, workflowto0_.title as title277_0_ from WorkflowToolData workflowto0_ where workflowto0_.id=?
25-Feb-2014 01:14:23 Hibernate: insert into Person (deleted, email, firstName, lastName, id) values (?, ?, ?, ?, ?)
25-Feb-2014 01:14:23 Hibernate: insert into Workflow (deleted, created, creator_id, description, title, id) values (?, ?, ?, ?, ?, ?)
25-Feb-2014 01:14:23 Hibernate: insert into WorkflowTool (deleted, creator_id, date, description, executor, implementation, previousVersion_id, title, version, id) values (?, ?, ?, ?, ?, ?, ?, ?, ?, ?)
25-Feb-2014 01:14:23 Hibernate: insert into WorkflowToolData (deleted, dataid, description, mimeType, title, id) values (?, ?, ?, ?, ?, ?)
25-Feb-2014 01:14:23 Hibernate: insert into WorkflowStep (deleted, createDate, creator_id, title, tool_id, id) values (?, ?, ?, ?, ?, ?)
25-Feb-2014 01:14:23 Hibernate: insert into WorkflowSteps (Workflow_id, steps_id) values (?, ?)
25-Feb-2014 01:14:23 Hibernate: insert into WorkflowToolOutputs (WorkflowTool_id, outputs_id) values (?, ?)
25-Feb-2014 01:14:23 Hibernate: insert into WorkflowStepOutputs (WorkflowStep_id, outputs_KEY, outputs) values (?, ?, ?)
25-Feb-2014 01:14:23 01:14:23,803  INFO ework.web.context.support.XmlWebApplicationContext: 500 - Refreshing Root WebApplicationContext: startup date [Tue Feb 25 01:14:23 CST 2014]; root of context hierarchy
25-Feb-2014 01:14:23 01:14:23,804  INFO ramework.beans.factory.xml.XmlBeanDefinitionReader: 315 - Loading XML bean definitions from ServletContext resource [/testContext.xml]
25-Feb-2014 01:14:23 01:14:23,836 DEBUG           edu.illinois.ncsa.cyberintegrator.Engine: 392 - Load queue with any unfinished steps
25-Feb-2014 01:14:23 Hibernate: select execution0_.id as id276_, execution0_.deleted as deleted276_, execution0_.creator_id as creator5_284_, execution0_.date as date284_, execution0_.description as descript2_284_, execution0_.title as title284_, execution0_.workflowId as workflowId284_ from Execution execution0_
25-Feb-2014 01:14:23 Hibernate: select person0_.id as id276_0_, person0_.deleted as deleted276_0_, person0_.email as email288_0_, person0_.firstName as firstName288_0_, person0_.lastName as lastName288_0_ from Person person0_ where person0_.id=?
25-Feb-2014 01:14:23 Hibernate: select stepstate0_.Execution_id as Execution1_276_0_, stepstate0_.state as state294_0_, stepstate0_.id as id0_ from ExecutionStepState stepstate0_ where stepstate0_.Execution_id=?
25-Feb-2014 01:14:23 Hibernate: select stepstate0_.Execution_id as Execution1_276_0_, stepstate0_.state as state294_0_, stepstate0_.id as id0_ from ExecutionStepState stepstate0_ where stepstate0_.Execution_id=?
25-Feb-2014 01:14:23 01:14:23,860 DEBUG           edu.illinois.ncsa.cyberintegrator.Engine: 436 - Finished loading queue.
25-Feb-2014 01:14:23 01:14:23,879  INFO gframework.jdbc.datasource.DriverManagerDataSource: 153 - Loaded JDBC driver: org.hsqldb.jdbcDriver
25-Feb-2014 01:14:23 01:14:23,879  INFO ework.web.context.support.XmlWebApplicationContext:1355 - Bean 'dataSource' of type [class org.springframework.jdbc.datasource.DriverManagerDataSource] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:23 01:14:23,881  INFO ework.web.context.support.XmlWebApplicationContext:1355 - Bean 'org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter#626b0f8f' of type [class org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:23 01:14:23,924  INFO ork.orm.jpa.LocalContainerEntityManagerFactoryBean: 264 - Building JPA container EntityManagerFactory for persistence unit 'default'
25-Feb-2014 01:14:23 01:14:23,925  INFO                org.hibernate.ejb.Ejb3Configuration: 527 - HHH000204: Processing PersistenceUnitInfo [
25-Feb-2014 01:14:23         name: default
25-Feb-2014 01:14:23         ...]
25-Feb-2014 01:14:23 01:14:23,955  INFO c.connections.internal.ConnectionProviderInitiator: 188 - HHH000130: Instantiating explicit connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
25-Feb-2014 01:14:23 01:14:23,957  INFO                      org.hibernate.dialect.Dialect: 125 - HHH000400: Using dialect: org.hibernate.dialect.HSQLDialect
25-Feb-2014 01:14:23 01:14:23,958  INFO e.transaction.internal.TransactionFactoryInitiator:  73 - HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jdbc.JdbcTransactionFactory
25-Feb-2014 01:14:23 01:14:23,958  INFO bernate.hql.internal.ast.ASTQueryTranslatorFactory:  48 - HHH000397: Using ASTQueryTranslatorFactory
25-Feb-2014 01:14:23 01:14:23,996  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 182 - HHH000228: Running hbm2ddl schema update
25-Feb-2014 01:14:23 01:14:23,996  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 193 - HHH000102: Fetching database metadata
25-Feb-2014 01:14:23 01:14:23,997  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 205 - HHH000396: Updating schema
25-Feb-2014 01:14:24 01:14:24,006  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.ABSTRACTBEAN
25-Feb-2014 01:14:24 01:14:24,006  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, deleted]
25-Feb-2014 01:14:24 01:14:24,007  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,007  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10094_10095]
25-Feb-2014 01:14:24 01:14:24,015  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.ACCOUNT
25-Feb-2014 01:14:24 01:14:24,015  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, person_id, userid, password, deleted]
25-Feb-2014 01:14:24 01:14:24,016  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk1d0c220d424b2244]
25-Feb-2014 01:14:24 01:14:24,016  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10098_10099, sys_idx_10231]
25-Feb-2014 01:14:24 01:14:24,024  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASET
25-Feb-2014 01:14:24 01:14:24,024  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, description, date, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,025  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkb93e4c5861a77a0d]
25-Feb-2014 01:14:24 01:14:24,025  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10102_10103, sys_idx_10233]
25-Feb-2014 01:14:24 01:14:24,033  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASETCONTRIBUTORS
25-Feb-2014 01:14:24 01:14:24,033  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, dataset_id]
25-Feb-2014 01:14:24 01:14:24,033  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkb059770defc2750, fkb0597702f8cbbc1]
25-Feb-2014 01:14:24 01:14:24,034  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10235, sys_idx_10237, sys_idx_sys_ct_10106_10108]
25-Feb-2014 01:14:24 01:14:24,042  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASETFILEDESCRIPTORS
25-Feb-2014 01:14:24 01:14:24,042  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [filedescriptors_id, dataset_id]
25-Feb-2014 01:14:24 01:14:24,043  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk95f77850cdcd8587, fk95f77850defc2750]
25-Feb-2014 01:14:24 01:14:24,043  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10239, sys_idx_10241]
25-Feb-2014 01:14:24 01:14:24,051  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTION
25-Feb-2014 01:14:24 01:14:24,051  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, description, date, workflowid, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,051  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk366b2af861a77a0d]
25-Feb-2014 01:14:24 01:14:24,051  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10114_10115, sys_idx_10243]
25-Feb-2014 01:14:24 01:14:24,059  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONDATASETS
25-Feb-2014 01:14:24 01:14:24,060  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [dataset, execution_id, uri]
25-Feb-2014 01:14:24 01:14:24,060  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fke677f21387f7d04e]
25-Feb-2014 01:14:24 01:14:24,060  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10245, sys_idx_sys_pk_10118_10119]
25-Feb-2014 01:14:24 01:14:24,068  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONPARAMETERS
25-Feb-2014 01:14:24 01:14:24,069  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [parameter, execution_id, uri]
25-Feb-2014 01:14:24 01:14:24,069  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkc1b5730287f7d04e]
25-Feb-2014 01:14:24 01:14:24,069  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10247, sys_idx_sys_pk_10122_10123]
25-Feb-2014 01:14:24 01:14:24,077  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONPROPERTIES
25-Feb-2014 01:14:24 01:14:24,077  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [pkey, pvalue, execution_id]
25-Feb-2014 01:14:24 01:14:24,077  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk6f2b3e4b87f7d04e]
25-Feb-2014 01:14:24 01:14:24,078  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10126_10127, sys_idx_10249]
25-Feb-2014 01:14:24 01:14:24,086  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPEND
25-Feb-2014 01:14:24 01:14:24,086  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:24 01:14:24,086  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk510fac5787f7d04e]
25-Feb-2014 01:14:24 01:14:24,087  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10251, sys_idx_sys_pk_10130_10131]
25-Feb-2014 01:14:24 01:14:24,095  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPQUEUED
25-Feb-2014 01:14:24 01:14:24,095  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:24 01:14:24,095  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk43c7647787f7d04e]
25-Feb-2014 01:14:24 01:14:24,095  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10134_10135, sys_idx_10253]
25-Feb-2014 01:14:24 01:14:24,104  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPSTART
25-Feb-2014 01:14:24 01:14:24,104  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:24 01:14:24,104  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk4c9df8de87f7d04e]
25-Feb-2014 01:14:24 01:14:24,104  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10255, sys_idx_sys_pk_10138_10139]
25-Feb-2014 01:14:24 01:14:24,112  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPSTATE
25-Feb-2014 01:14:24 01:14:24,112  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, state, execution_id]
25-Feb-2014 01:14:24 01:14:24,113  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk4c9df90d87f7d04e]
25-Feb-2014 01:14:24 01:14:24,113  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10257, sys_idx_sys_pk_10142_10143]
25-Feb-2014 01:14:24 01:14:24,121  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.FILEDESCRIPTOR
25-Feb-2014 01:14:24 01:14:24,121  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [md5sum, id, mimetype, dataurl, filename, deleted, size]
25-Feb-2014 01:14:24 01:14:24,121  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,121  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10147_10148]
25-Feb-2014 01:14:24 01:14:24,130  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.HPCJOBINFO
25-Feb-2014 01:14:24 01:14:24,130  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, standardoutput, workingdir, standarderror, executionid, deleted, jobid]
25-Feb-2014 01:14:24 01:14:24,130  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,130  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10151_10152]
25-Feb-2014 01:14:24 01:14:24,138  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.LOGFILE
25-Feb-2014 01:14:24 01:14:24,138  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, executionid, stepid, date, deleted, log_id]
25-Feb-2014 01:14:24 01:14:24,139  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk779062c0626974ab]
25-Feb-2014 01:14:24 01:14:24,139  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10259, sys_idx_sys_pk_10155_10156]
25-Feb-2014 01:14:24 01:14:24,147  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.PERSON
25-Feb-2014 01:14:24 01:14:24,148  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, email, lastname, firstname, deleted]
25-Feb-2014 01:14:24 01:14:24,148  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,148  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10159_10160]
25-Feb-2014 01:14:24 01:14:24,157  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.TOOLBLOBS
25-Feb-2014 01:14:24 01:14:24,157  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, blobs_id]
25-Feb-2014 01:14:24 01:14:24,157  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk5d0ac99e7c2a6e39, fk5d0ac99ed5bfd466]
25-Feb-2014 01:14:24 01:14:24,158  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10163_10165, sys_idx_sys_ct_10164_10166, sys_idx_10261, sys_idx_10263]
25-Feb-2014 01:14:24 01:14:24,167  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOW
25-Feb-2014 01:14:24 01:14:24,167  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, created, description, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,167  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk5f63bdf61a77a0d]
25-Feb-2014 01:14:24 01:14:24,167  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10169_10170, sys_idx_10265]
25-Feb-2014 01:14:24 01:14:24,176  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWCONTRIBUTORS
25-Feb-2014 01:14:24 01:14:24,176  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, workflow_id]
25-Feb-2014 01:14:24 01:14:24,176  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk176774772f8cbbc1, fk17677477cbde8d46]
25-Feb-2014 01:14:24 01:14:24,176  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10267, sys_idx_10269, sys_idx_sys_ct_10173_10175]
25-Feb-2014 01:14:24 01:14:24,185  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEP
25-Feb-2014 01:14:24 01:14:24,185  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, createdate, tool_id, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,185  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk66ceaf4b61a77a0d, fk66ceaf4bbe8b1105]
25-Feb-2014 01:14:24 01:14:24,185  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10178_10179, sys_idx_10271, sys_idx_10273]
25-Feb-2014 01:14:24 01:14:24,193  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPINPUTS
25-Feb-2014 01:14:24 01:14:24,194  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [inputs, inputs_key, workflowstep_id]
25-Feb-2014 01:14:24 01:14:24,194  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkf9175914a8d657e6]
25-Feb-2014 01:14:24 01:14:24,194  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10275, sys_idx_sys_pk_10181_10182]
25-Feb-2014 01:14:24 01:14:24,202  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPOUTPUTS
25-Feb-2014 01:14:24 01:14:24,202  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [outputs_key, outputs, workflowstep_id]
25-Feb-2014 01:14:24 01:14:24,202  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk736135c7a8d657e6]
25-Feb-2014 01:14:24 01:14:24,203  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10184_10185, sys_idx_10277]
25-Feb-2014 01:14:24 01:14:24,211  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPPARAMETERS
25-Feb-2014 01:14:24 01:14:24,211  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [parameters_key, parameters, workflowstep_id]
25-Feb-2014 01:14:24 01:14:24,211  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk44a9eb95a8d657e6]
25-Feb-2014 01:14:24 01:14:24,211  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10187_10188, sys_idx_10279]
25-Feb-2014 01:14:24 01:14:24,219  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPS
25-Feb-2014 01:14:24 01:14:24,220  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflow_id, steps_id]
25-Feb-2014 01:14:24 01:14:24,220  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk73073a88cbde8d46, fk73073a8857b2a64a]
25-Feb-2014 01:14:24 01:14:24,220  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10283, sys_idx_10281, sys_idx_sys_ct_10191_10193]
25-Feb-2014 01:14:24 01:14:24,228  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOL
25-Feb-2014 01:14:24 01:14:24,229  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, previousversion_id, implementation, description, executor, date, deleted, creator_id, version]
25-Feb-2014 01:14:24 01:14:24,229  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk66cf121761a77a0d, fk66cf1217a56447fc]
25-Feb-2014 01:14:24 01:14:24,229  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10287, sys_idx_10285, sys_idx_sys_pk_10196_10197]
25-Feb-2014 01:14:24 01:14:24,237  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLCONTRIBUTORS
25-Feb-2014 01:14:24 01:14:24,238  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, workflowtool_id]
25-Feb-2014 01:14:24 01:14:24,238  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fka858b6af2f8cbbc1, fka858b6afd5bfd466]
25-Feb-2014 01:14:24 01:14:24,238  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10200_10202, sys_idx_10289, sys_idx_sys_ct_10201_10203, sys_idx_10291]
25-Feb-2014 01:14:24 01:14:24,246  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLDATA
25-Feb-2014 01:14:24 01:14:24,247  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, mimetype, description, dataid, deleted]
25-Feb-2014 01:14:24 01:14:24,247  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,247  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10206_10207]
25-Feb-2014 01:14:24 01:14:24,255  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLINPUTS
25-Feb-2014 01:14:24 01:14:24,255  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, inputs_id]
25-Feb-2014 01:14:24 01:14:24,255  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk433d72e0d5bfd466, fk433d72e0fc8b655e]
25-Feb-2014 01:14:24 01:14:24,255  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10293, sys_idx_10295, sys_idx_sys_ct_10210_10212]
25-Feb-2014 01:14:24 01:14:24,263  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLOUTPUTS
25-Feb-2014 01:14:24 01:14:24,264  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, outputs_id]
25-Feb-2014 01:14:24 01:14:24,264  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk6dfe557bd5bfd466, fk6dfe557b4adfb315]
25-Feb-2014 01:14:24 01:14:24,264  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10297, sys_idx_sys_ct_10215_10217, sys_idx_10299]
25-Feb-2014 01:14:24 01:14:24,272  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETER
25-Feb-2014 01:14:24 01:14:24,272  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, paramid, hidden, description, value, type, allownull, deleted]
25-Feb-2014 01:14:24 01:14:24,273  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,273  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10222_10223]
25-Feb-2014 01:14:24 01:14:24,281  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETER_OPTIONS
25-Feb-2014 01:14:24 01:14:24,281  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtoolparameter_id, options]
25-Feb-2014 01:14:24 01:14:24,282  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk1a35e6b18f0763ce]
25-Feb-2014 01:14:24 01:14:24,282  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10301]
25-Feb-2014 01:14:24 01:14:24,290  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETERS
25-Feb-2014 01:14:24 01:14:24,290  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, parameters_id]
25-Feb-2014 01:14:24 01:14:24,290  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk77563f61d5bfd466, fk77563f61d511e296]
25-Feb-2014 01:14:24 01:14:24,290  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10305, sys_idx_10303, sys_idx_sys_ct_10228_10230]
25-Feb-2014 01:14:24 01:14:24,291  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 240 - HHH000232: Schema update complete
25-Feb-2014 01:14:24 01:14:24,301  WARN ibernate.ejb.internal.EntityManagerFactoryRegistry:  80 - HHH000436: Entity manager factory name (default) is already registered.  If entity manager will be clustered or passivated, specify a unique value for property 'hibernate.ejb.entitymanager_factory_name'
25-Feb-2014 01:14:24 01:14:24,301  INFO ework.web.context.support.XmlWebApplicationContext:1355 - Bean 'entityManagerFactory' of type [class org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:24 01:14:24,304  INFO k.beans.factory.support.DefaultListableBeanFactory: 581 - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@77c4e870: defining beans [engine,applicationContextProvider,fileStorage,eventBus,entityManagerFactory,transactionManager,dataSource,accountDAO,pagingAndSortingAndDeleteRepository,datasetDAO,personDAO,fileDescriptorDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#0,org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,workflowToolDataDAO,workflowDAO,workflowToolParameterDAO,executionDAO,hPCJobInfoDAO,workflowToolDAO,logFileDAO,workflowStepDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#1]; root of factory hierarchy
25-Feb-2014 01:14:24 01:14:24,305  INFO           edu.illinois.ncsa.cyberintegrator.Engine: 200 - Adding executor : java
25-Feb-2014 01:14:24 01:14:24,305  INFO           edu.illinois.ncsa.cyberintegrator.Engine: 200 - Adding executor : commandline
25-Feb-2014 01:14:24 01:14:24,323  INFO                                    org.mortbay.log:  67 - jetty-6.1.21
25-Feb-2014 01:14:24 01:14:24,338  INFO          org.jboss.resteasy.spi.ResteasyDeployment:  82 - Deploying javax.ws.rs.core.Application: class edu.illinois.ncsa.cyberintegrator.service.CyberIntegratorApplication
25-Feb-2014 01:14:24 01:14:24,365  INFO                                                  /:  67 - Initializing Spring root WebApplicationContext
25-Feb-2014 01:14:24 01:14:24,365  INFO      org.springframework.web.context.ContextLoader: 272 - Root WebApplicationContext: initialization started
25-Feb-2014 01:14:24 01:14:24,366  INFO ework.web.context.support.XmlWebApplicationContext: 500 - Refreshing Root WebApplicationContext: startup date [Tue Feb 25 01:14:24 CST 2014]; root of context hierarchy
25-Feb-2014 01:14:24 01:14:24,366  INFO k.beans.factory.support.DefaultListableBeanFactory: 433 - Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@77c4e870: defining beans [engine,applicationContextProvider,fileStorage,eventBus,entityManagerFactory,transactionManager,dataSource,accountDAO,pagingAndSortingAndDeleteRepository,datasetDAO,personDAO,fileDescriptorDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#0,org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,workflowToolDataDAO,workflowDAO,workflowToolParameterDAO,executionDAO,hPCJobInfoDAO,workflowToolDAO,logFileDAO,workflowStepDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#1]; root of factory hierarchy
25-Feb-2014 01:14:24 01:14:24,368  INFO ork.orm.jpa.LocalContainerEntityManagerFactoryBean: 441 - Closing JPA EntityManagerFactory for persistence unit 'default'
25-Feb-2014 01:14:24 01:14:24,369  INFO ramework.beans.factory.xml.XmlBeanDefinitionReader: 315 - Loading XML bean definitions from ServletContext resource [/testContext.xml]
25-Feb-2014 01:14:24 Exception in thread "EngineThread" java.lang.IllegalStateException: BeanFactory not initialized or already closed - call 'refresh' before accessing beans via the ApplicationContext
25-Feb-2014 01:14:24         at org.springframework.context.support.AbstractRefreshableApplicationContext.getBeanFactory(AbstractRefreshableApplicationContext.java:172)
25-Feb-2014 01:14:24         at org.springframework.context.support.AbstractApplicationContext.getBean(AbstractApplicationContext.java:1098)
25-Feb-2014 01:14:24         at edu.illinois.ncsa.springdata.SpringData.getTransaction(SpringData.java:87)
25-Feb-2014 01:14:24         at edu.illinois.ncsa.cyberintegrator.Engine$WorkerThread.run(Engine.java:446)
25-Feb-2014 01:14:24 01:14:24,434  INFO gframework.jdbc.datasource.DriverManagerDataSource: 153 - Loaded JDBC driver: org.hsqldb.jdbcDriver
25-Feb-2014 01:14:24 01:14:24,434  INFO ework.web.context.support.XmlWebApplicationContext:1355 - Bean 'dataSource' of type [class org.springframework.jdbc.datasource.DriverManagerDataSource] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:24 01:14:24,435  INFO ework.web.context.support.XmlWebApplicationContext:1355 - Bean 'org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter#620831c7' of type [class org.springframework.orm.jpa.vendor.HibernateJpaVendorAdapter] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:24 01:14:24,475  INFO ork.orm.jpa.LocalContainerEntityManagerFactoryBean: 264 - Building JPA container EntityManagerFactory for persistence unit 'default'
25-Feb-2014 01:14:24 01:14:24,475  INFO                org.hibernate.ejb.Ejb3Configuration: 527 - HHH000204: Processing PersistenceUnitInfo [
25-Feb-2014 01:14:24         name: default
25-Feb-2014 01:14:24         ...]
25-Feb-2014 01:14:24 01:14:24,502  INFO c.connections.internal.ConnectionProviderInitiator: 188 - HHH000130: Instantiating explicit connection provider: org.hibernate.ejb.connection.InjectedDataSourceConnectionProvider
25-Feb-2014 01:14:24 01:14:24,503  INFO                      org.hibernate.dialect.Dialect: 125 - HHH000400: Using dialect: org.hibernate.dialect.HSQLDialect
25-Feb-2014 01:14:24 01:14:24,504  INFO e.transaction.internal.TransactionFactoryInitiator:  73 - HHH000268: Transaction strategy: org.hibernate.engine.transaction.internal.jdbc.JdbcTransactionFactory
25-Feb-2014 01:14:24 01:14:24,504  INFO bernate.hql.internal.ast.ASTQueryTranslatorFactory:  48 - HHH000397: Using ASTQueryTranslatorFactory
25-Feb-2014 01:14:24 01:14:24,540  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 182 - HHH000228: Running hbm2ddl schema update
25-Feb-2014 01:14:24 01:14:24,540  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 193 - HHH000102: Fetching database metadata
25-Feb-2014 01:14:24 01:14:24,541  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 205 - HHH000396: Updating schema
25-Feb-2014 01:14:24 01:14:24,550  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.ABSTRACTBEAN
25-Feb-2014 01:14:24 01:14:24,550  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, deleted]
25-Feb-2014 01:14:24 01:14:24,550  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,550  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10094_10095]
25-Feb-2014 01:14:24 01:14:24,559  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.ACCOUNT
25-Feb-2014 01:14:24 01:14:24,559  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, person_id, userid, password, deleted]
25-Feb-2014 01:14:24 01:14:24,559  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk1d0c220d424b2244]
25-Feb-2014 01:14:24 01:14:24,560  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10098_10099, sys_idx_10231]
25-Feb-2014 01:14:24 01:14:24,568  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASET
25-Feb-2014 01:14:24 01:14:24,569  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, description, date, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,569  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkb93e4c5861a77a0d]
25-Feb-2014 01:14:24 01:14:24,569  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10102_10103, sys_idx_10233]
25-Feb-2014 01:14:24 01:14:24,578  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASETCONTRIBUTORS
25-Feb-2014 01:14:24 01:14:24,579  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, dataset_id]
25-Feb-2014 01:14:24 01:14:24,579  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkb059770defc2750, fkb0597702f8cbbc1]
25-Feb-2014 01:14:24 01:14:24,579  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10235, sys_idx_10237, sys_idx_sys_ct_10106_10108]
25-Feb-2014 01:14:24 01:14:24,588  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.DATASETFILEDESCRIPTORS
25-Feb-2014 01:14:24 01:14:24,588  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [filedescriptors_id, dataset_id]
25-Feb-2014 01:14:24 01:14:24,588  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk95f77850cdcd8587, fk95f77850defc2750]
25-Feb-2014 01:14:24 01:14:24,589  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10239, sys_idx_10241]
25-Feb-2014 01:14:24 01:14:24,597  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTION
25-Feb-2014 01:14:24 01:14:24,597  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, description, date, workflowid, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,598  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk366b2af861a77a0d]
25-Feb-2014 01:14:24 01:14:24,598  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10114_10115, sys_idx_10243]
25-Feb-2014 01:14:24 01:14:24,606  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONDATASETS
25-Feb-2014 01:14:24 01:14:24,606  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [dataset, execution_id, uri]
25-Feb-2014 01:14:24 01:14:24,607  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fke677f21387f7d04e]
25-Feb-2014 01:14:24 01:14:24,607  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10245, sys_idx_sys_pk_10118_10119]
25-Feb-2014 01:14:24 01:14:24,616  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONPARAMETERS
25-Feb-2014 01:14:24 01:14:24,616  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [parameter, execution_id, uri]
25-Feb-2014 01:14:24 01:14:24,616  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkc1b5730287f7d04e]
25-Feb-2014 01:14:24 01:14:24,617  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10247, sys_idx_sys_pk_10122_10123]
25-Feb-2014 01:14:24 01:14:24,625  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONPROPERTIES
25-Feb-2014 01:14:24 01:14:24,625  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [pkey, pvalue, execution_id]
25-Feb-2014 01:14:24 01:14:24,625  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk6f2b3e4b87f7d04e]
25-Feb-2014 01:14:24 01:14:24,626  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10126_10127, sys_idx_10249]
25-Feb-2014 01:14:24 01:14:24,634  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPEND
25-Feb-2014 01:14:24 01:14:24,634  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:24 01:14:24,635  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk510fac5787f7d04e]
25-Feb-2014 01:14:24 01:14:24,635  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10251, sys_idx_sys_pk_10130_10131]
25-Feb-2014 01:14:24 01:14:24,643  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPQUEUED
25-Feb-2014 01:14:24 01:14:24,644  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:24 01:14:24,644  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk43c7647787f7d04e]
25-Feb-2014 01:14:24 01:14:24,644  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10134_10135, sys_idx_10253]
25-Feb-2014 01:14:24 01:14:24,653  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPSTART
25-Feb-2014 01:14:24 01:14:24,653  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, execution_id, date]
25-Feb-2014 01:14:24 01:14:24,653  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk4c9df8de87f7d04e]
25-Feb-2014 01:14:24 01:14:24,653  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10255, sys_idx_sys_pk_10138_10139]
25-Feb-2014 01:14:24 01:14:24,662  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.EXECUTIONSTEPSTATE
25-Feb-2014 01:14:24 01:14:24,662  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, state, execution_id]
25-Feb-2014 01:14:24 01:14:24,662  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk4c9df90d87f7d04e]
25-Feb-2014 01:14:24 01:14:24,663  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10257, sys_idx_sys_pk_10142_10143]
25-Feb-2014 01:14:24 01:14:24,671  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.FILEDESCRIPTOR
25-Feb-2014 01:14:24 01:14:24,671  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [md5sum, id, mimetype, dataurl, filename, deleted, size]
25-Feb-2014 01:14:24 01:14:24,672  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,672  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10147_10148]
25-Feb-2014 01:14:24 01:14:24,680  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.HPCJOBINFO
25-Feb-2014 01:14:24 01:14:24,681  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, standardoutput, workingdir, standarderror, executionid, deleted, jobid]
25-Feb-2014 01:14:24 01:14:24,681  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,681  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10151_10152]
25-Feb-2014 01:14:24 01:14:24,690  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.LOGFILE
25-Feb-2014 01:14:24 01:14:24,690  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, executionid, stepid, date, deleted, log_id]
25-Feb-2014 01:14:24 01:14:24,690  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk779062c0626974ab]
25-Feb-2014 01:14:24 01:14:24,690  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10259, sys_idx_sys_pk_10155_10156]
25-Feb-2014 01:14:24 01:14:24,699  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.PERSON
25-Feb-2014 01:14:24 01:14:24,699  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, email, lastname, firstname, deleted]
25-Feb-2014 01:14:24 01:14:24,700  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,700  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10159_10160]
25-Feb-2014 01:14:24 01:14:24,708  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.TOOLBLOBS
25-Feb-2014 01:14:24 01:14:24,709  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, blobs_id]
25-Feb-2014 01:14:24 01:14:24,709  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk5d0ac99e7c2a6e39, fk5d0ac99ed5bfd466]
25-Feb-2014 01:14:24 01:14:24,709  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10163_10165, sys_idx_sys_ct_10164_10166, sys_idx_10261, sys_idx_10263]
25-Feb-2014 01:14:24 01:14:24,717  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOW
25-Feb-2014 01:14:24 01:14:24,717  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, created, description, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,718  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk5f63bdf61a77a0d]
25-Feb-2014 01:14:24 01:14:24,718  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10169_10170, sys_idx_10265]
25-Feb-2014 01:14:24 01:14:24,726  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWCONTRIBUTORS
25-Feb-2014 01:14:24 01:14:24,726  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, workflow_id]
25-Feb-2014 01:14:24 01:14:24,727  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk176774772f8cbbc1, fk17677477cbde8d46]
25-Feb-2014 01:14:24 01:14:24,727  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10267, sys_idx_10269, sys_idx_sys_ct_10173_10175]
25-Feb-2014 01:14:24 01:14:24,735  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEP
25-Feb-2014 01:14:24 01:14:24,735  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, createdate, tool_id, deleted, creator_id]
25-Feb-2014 01:14:24 01:14:24,736  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk66ceaf4b61a77a0d, fk66ceaf4bbe8b1105]
25-Feb-2014 01:14:24 01:14:24,736  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10178_10179, sys_idx_10271, sys_idx_10273]
25-Feb-2014 01:14:24 01:14:24,744  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPINPUTS
25-Feb-2014 01:14:24 01:14:24,744  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [inputs, inputs_key, workflowstep_id]
25-Feb-2014 01:14:24 01:14:24,745  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fkf9175914a8d657e6]
25-Feb-2014 01:14:24 01:14:24,745  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10275, sys_idx_sys_pk_10181_10182]
25-Feb-2014 01:14:24 01:14:24,753  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPOUTPUTS
25-Feb-2014 01:14:24 01:14:24,753  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [outputs_key, outputs, workflowstep_id]
25-Feb-2014 01:14:24 01:14:24,754  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk736135c7a8d657e6]
25-Feb-2014 01:14:24 01:14:24,754  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10184_10185, sys_idx_10277]
25-Feb-2014 01:14:24 01:14:24,762  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPPARAMETERS
25-Feb-2014 01:14:24 01:14:24,762  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [parameters_key, parameters, workflowstep_id]
25-Feb-2014 01:14:24 01:14:24,762  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk44a9eb95a8d657e6]
25-Feb-2014 01:14:24 01:14:24,763  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10187_10188, sys_idx_10279]
25-Feb-2014 01:14:24 01:14:24,771  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWSTEPS
25-Feb-2014 01:14:24 01:14:24,771  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflow_id, steps_id]
25-Feb-2014 01:14:24 01:14:24,772  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk73073a88cbde8d46, fk73073a8857b2a64a]
25-Feb-2014 01:14:24 01:14:24,772  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10283, sys_idx_10281, sys_idx_sys_ct_10191_10193]
25-Feb-2014 01:14:24 01:14:24,780  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOL
25-Feb-2014 01:14:24 01:14:24,780  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, previousversion_id, implementation, description, executor, date, deleted, creator_id, version]
25-Feb-2014 01:14:24 01:14:24,781  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk66cf121761a77a0d, fk66cf1217a56447fc]
25-Feb-2014 01:14:24 01:14:24,781  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10287, sys_idx_10285, sys_idx_sys_pk_10196_10197]
25-Feb-2014 01:14:24 01:14:24,789  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLCONTRIBUTORS
25-Feb-2014 01:14:24 01:14:24,789  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [contributors_id, workflowtool_id]
25-Feb-2014 01:14:24 01:14:24,790  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fka858b6af2f8cbbc1, fka858b6afd5bfd466]
25-Feb-2014 01:14:24 01:14:24,790  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10200_10202, sys_idx_10289, sys_idx_sys_ct_10201_10203, sys_idx_10291]
25-Feb-2014 01:14:24 01:14:24,798  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLDATA
25-Feb-2014 01:14:24 01:14:24,799  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, mimetype, description, dataid, deleted]
25-Feb-2014 01:14:24 01:14:24,799  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,799  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10206_10207]
25-Feb-2014 01:14:24 01:14:24,807  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLINPUTS
25-Feb-2014 01:14:24 01:14:24,808  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, inputs_id]
25-Feb-2014 01:14:24 01:14:24,808  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk433d72e0d5bfd466, fk433d72e0fc8b655e]
25-Feb-2014 01:14:24 01:14:24,808  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10293, sys_idx_10295, sys_idx_sys_ct_10210_10212]
25-Feb-2014 01:14:24 01:14:24,816  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLOUTPUTS
25-Feb-2014 01:14:24 01:14:24,817  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, outputs_id]
25-Feb-2014 01:14:24 01:14:24,817  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk6dfe557bd5bfd466, fk6dfe557b4adfb315]
25-Feb-2014 01:14:24 01:14:24,817  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10297, sys_idx_sys_ct_10215_10217, sys_idx_10299]
25-Feb-2014 01:14:24 01:14:24,826  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETER
25-Feb-2014 01:14:24 01:14:24,826  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [id, title, paramid, hidden, description, value, type, allownull, deleted]
25-Feb-2014 01:14:24 01:14:24,826  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: []
25-Feb-2014 01:14:24 01:14:24,827  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_sys_pk_10222_10223]
25-Feb-2014 01:14:24 01:14:24,836  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETER_OPTIONS
25-Feb-2014 01:14:24 01:14:24,836  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtoolparameter_id, options]
25-Feb-2014 01:14:24 01:14:24,836  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk1a35e6b18f0763ce]
25-Feb-2014 01:14:24 01:14:24,836  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10301]
25-Feb-2014 01:14:24 01:14:24,845  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  65 - HHH000261: Table found: PUBLIC.PUBLIC.WORKFLOWTOOLPARAMETERS
25-Feb-2014 01:14:24 01:14:24,845  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  66 - HHH000037: Columns: [workflowtool_id, parameters_id]
25-Feb-2014 01:14:24 01:14:24,845  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  68 - HHH000108: Foreign keys: [fk77563f61d5bfd466, fk77563f61d511e296]
25-Feb-2014 01:14:24 01:14:24,846  INFO           org.hibernate.tool.hbm2ddl.TableMetadata:  69 - HHH000126: Indexes: [sys_idx_10305, sys_idx_10303, sys_idx_sys_ct_10228_10230]
25-Feb-2014 01:14:24 01:14:24,846  INFO            org.hibernate.tool.hbm2ddl.SchemaUpdate: 240 - HHH000232: Schema update complete
25-Feb-2014 01:14:24 01:14:24,855  WARN ibernate.ejb.internal.EntityManagerFactoryRegistry:  80 - HHH000436: Entity manager factory name (default) is already registered.  If entity manager will be clustered or passivated, specify a unique value for property 'hibernate.ejb.entitymanager_factory_name'
25-Feb-2014 01:14:24 01:14:24,856  INFO ework.web.context.support.XmlWebApplicationContext:1355 - Bean 'entityManagerFactory' of type [class org.springframework.orm.jpa.LocalContainerEntityManagerFactoryBean] is not eligible for getting processed by all BeanPostProcessors (for example: not eligible for auto-proxying)
25-Feb-2014 01:14:24 01:14:24,858  INFO k.beans.factory.support.DefaultListableBeanFactory: 581 - Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@cb8c5d9: defining beans [engine,applicationContextProvider,fileStorage,eventBus,entityManagerFactory,transactionManager,dataSource,personDAO,accountDAO,datasetDAO,pagingAndSortingAndDeleteRepository,fileDescriptorDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#0,org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,logFileDAO,workflowToolDataDAO,workflowStepDAO,executionDAO,workflowToolParameterDAO,workflowToolDAO,workflowDAO,hPCJobInfoDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#1]; root of factory hierarchy
25-Feb-2014 01:14:24 01:14:24,859  INFO           edu.illinois.ncsa.cyberintegrator.Engine: 200 - Adding executor : java
25-Feb-2014 01:14:24 01:14:24,859  INFO           edu.illinois.ncsa.cyberintegrator.Engine: 200 - Adding executor : commandline
25-Feb-2014 01:14:24 01:14:24,876  INFO      org.springframework.web.context.ContextLoader: 301 - Root WebApplicationContext: initialization completed in 510 ms
25-Feb-2014 01:14:24 01:14:24,877  INFO                                    org.mortbay.log:  67 - Started SocketConnector@0.0.0.0:9977
25-Feb-2014 01:14:24 http://localhost:9977
25-Feb-2014 01:14:24 01:14:24,878  INFO a.cyberintegrator.service.WorkflowsResourceGetTest:  60 - Test get workflow by id
25-Feb-2014 01:14:24 01:14:24,878  INFO grator.service.client.CyberintegratorServiceClient: 451 - executing request GET http://localhost:9977/workflows/ac4c5002-0c0f-465b-a64d-c6a1d5a9580a HTTP/1.1
25-Feb-2014 01:14:24 01:14:24,883  WARN ois.ncsa.cyberintegrator.service.WorkflowsResource: 235 - get workflow by id
25-Feb-2014 01:14:24 Hibernate: select workflow0_.id as id368_1_, workflow0_.deleted as deleted368_1_, workflow0_.created as created375_1_, workflow0_.creator_id as creator4_375_1_, workflow0_.description as descript2_375_1_, workflow0_.title as title375_1_, person1_.id as id368_0_, person1_.deleted as deleted368_0_, person1_.email as email380_0_, person1_.firstName as firstName380_0_, person1_.lastName as lastName380_0_ from Workflow workflow0_ left outer join Person person1_ on workflow0_.creator_id=person1_.id where workflow0_.id=?
25-Feb-2014 01:14:24 Hibernate: select contributo0_.Workflow_id as Workflow1_368_1_, contributo0_.contributors_id as contribu2_391_1_, person1_.id as id368_0_, person1_.deleted as deleted368_0_, person1_.email as email380_0_, person1_.firstName as firstName380_0_, person1_.lastName as lastName380_0_ from WorkflowContributors contributo0_ inner join Person person1_ on contributo0_.contributors_id=person1_.id where contributo0_.Workflow_id=?
25-Feb-2014 01:14:24 Hibernate: select steps0_.Workflow_id as Workflow1_368_4_, steps0_.steps_id as steps2_390_4_, workflowst1_.id as id368_0_, workflowst1_.deleted as deleted368_0_, workflowst1_.createDate as createDate374_0_, workflowst1_.creator_id as creator3_374_0_, workflowst1_.title as title374_0_, workflowst1_.tool_id as tool4_374_0_, person2_.id as id368_1_, person2_.deleted as deleted368_1_, person2_.email as email380_1_, person2_.firstName as firstName380_1_, person2_.lastName as lastName380_1_, workflowto3_.id as id368_2_, workflowto3_.deleted as deleted368_2_, workflowto3_.creator_id as creator7_370_2_, workflowto3_.date as date370_2_, workflowto3_.description as descript2_370_2_, workflowto3_.executor as executor370_2_, workflowto3_.implementation as implemen4_370_2_, workflowto3_.previousVersion_id as previous8_370_2_, workflowto3_.title as title370_2_, workflowto3_.version as version370_2_, person4_.id as id368_3_, person4_.deleted as deleted368_3_, person4_.email as email380_3_, person4_.firstName as firstName380_3_, person4_.lastName as lastName380_3_ from WorkflowSteps steps0_ inner join WorkflowStep workflowst1_ on steps0_.steps_id=workflowst1_.id left outer join Person person2_ on workflowst1_.creator_id=person2_.id left outer join WorkflowTool workflowto3_ on workflowst1_.tool_id=workflowto3_.id left outer join Person person4_ on workflowto3_.creator_id=person4_.id where steps0_.Workflow_id=?
25-Feb-2014 01:14:24 Hibernate: select contributo0_.WorkflowTool_id as Workflow1_368_1_, contributo0_.contributors_id as contribu2_399_1_, person1_.id as id368_0_, person1_.deleted as deleted368_0_, person1_.email as email380_0_, person1_.firstName as firstName380_0_, person1_.lastName as lastName380_0_ from WorkflowToolContributors contributo0_ inner join Person person1_ on contributo0_.contributors_id=person1_.id where contributo0_.WorkflowTool_id=?
25-Feb-2014 01:14:24 Hibernate: select inputs0_.WorkflowTool_id as Workflow1_368_1_, inputs0_.inputs_id as inputs2_398_1_, workflowto1_.id as id368_0_, workflowto1_.deleted as deleted368_0_, workflowto1_.dataid as dataid369_0_, workflowto1_.description as descript2_369_0_, workflowto1_.mimeType as mimeType369_0_, workflowto1_.title as title369_0_ from WorkflowToolInputs inputs0_ inner join WorkflowToolData workflowto1_ on inputs0_.inputs_id=workflowto1_.id where inputs0_.WorkflowTool_id=?
25-Feb-2014 01:14:24 Hibernate: select outputs0_.WorkflowTool_id as Workflow1_368_1_, outputs0_.outputs_id as outputs2_397_1_, workflowto1_.id as id368_0_, workflowto1_.deleted as deleted368_0_, workflowto1_.dataid as dataid369_0_, workflowto1_.description as descript2_369_0_, workflowto1_.mimeType as mimeType369_0_, workflowto1_.title as title369_0_ from WorkflowToolOutputs outputs0_ inner join WorkflowToolData workflowto1_ on outputs0_.outputs_id=workflowto1_.id where outputs0_.WorkflowTool_id=?
25-Feb-2014 01:14:24 Hibernate: select parameters0_.WorkflowTool_id as Workflow1_368_1_, parameters0_.parameters_id as parameters2_396_1_, workflowto1_.id as id368_0_, workflowto1_.deleted as deleted368_0_, workflowto1_.allowNull as allowNull371_0_, workflowto1_.description as descript2_371_0_, workflowto1_.hidden as hidden371_0_, workflowto1_.paramid as paramid371_0_, workflowto1_.title as title371_0_, workflowto1_.type as type371_0_, workflowto1_.value as value371_0_ from WorkflowToolParameters parameters0_ inner join WorkflowToolParameter workflowto1_ on parameters0_.parameters_id=workflowto1_.id where parameters0_.WorkflowTool_id=?
25-Feb-2014 01:14:24 Hibernate: select blobs0_.WorkflowTool_id as Workflow1_368_1_, blobs0_.blobs_id as blobs2_400_1_, filedescri1_.id as id368_0_, filedescri1_.deleted as deleted368_0_, filedescri1_.dataURL as dataURL377_0_, filedescri1_.filename as filename377_0_, filedescri1_.md5sum as md3_377_0_, filedescri1_.mimetype as mimetype377_0_, filedescri1_.size as size377_0_ from ToolBlobs blobs0_ inner join FileDescriptor filedescri1_ on blobs0_.blobs_id=filedescri1_.id where blobs0_.WorkflowTool_id=?
25-Feb-2014 01:14:24 Hibernate: select parameters0_.WorkflowStep_id as Workflow1_368_0_, parameters0_.parameters as parameters392_0_, parameters0_.parameters_KEY as parameters3_0_ from WorkflowStepParameters parameters0_ where parameters0_.WorkflowStep_id=?
25-Feb-2014 01:14:24 Hibernate: select inputs0_.WorkflowStep_id as Workflow1_368_0_, inputs0_.inputs as inputs394_0_, inputs0_.inputs_KEY as inputs3_0_ from WorkflowStepInputs inputs0_ where inputs0_.WorkflowStep_id=?
25-Feb-2014 01:14:24 Hibernate: select outputs0_.WorkflowStep_id as Workflow1_368_0_, outputs0_.outputs as outputs393_0_, outputs0_.outputs_KEY as outputs3_0_ from WorkflowStepOutputs outputs0_ where outputs0_.WorkflowStep_id=?
25-Feb-2014 01:14:24 01:14:24,939 DEBUG grator.service.client.CyberintegratorServiceClient: 455 - Response String: {"id":"ac4c5002-0c0f-465b-a64d-c6a1d5a9580a","deleted":false,"title":"TEST WORKFLOW","description":"","created":"2014-02-25T01:14:23-0600","creator":{"id":"0c23fab2-4ba3-4d36-ba33-880941d6a930","deleted":false,"firstName":"Jong","lastName":"Lee","email":"jonglee1@illinois.edu"},"contributors":[],"steps":[{"id":"f0cdd8f6-3860-42bb-947d-87bd190334c0","deleted":false,"title":"","creator":{"id":"0c23fab2-4ba3-4d36-ba33-880941d6a930","deleted":false,"firstName":"Jong","lastName":"Lee","email":"jonglee1@illinois.edu"},"createDate":"2014-02-25T01:14:23-0600","tool":{"id":"a5e1ee59-b1d2-44dc-aadf-1a3bfca75728","deleted":false,"title":"Netstat","description":"Command Line Executor","version":"1","previousVersion":null,"date":"2014-02-25T01:14:23-0600","implementation":"{\"executable\":\"netstat\",\"commandLineOptions\":[{\"type\":\"VALUE\",\"optionId\":null,\"flag\":\"-n\",\"value\":null,\"commandline\":true,\"inputOutput\":null,\"filename\":null}],\"env\":{},\"captureStdOut\":\"output\",\"captureStdErr\":null,\"joinStdOutStdErr\":false}","creator":{"id":"0c23fab2-4ba3-4d36-ba33-880941d6a930","deleted":false,"firstName":"Jong","lastName":"Lee","email":"jonglee1@illinois.edu"},"contributors":[],"inputs":[],"outputs":[{"id":"729b5ea4-61c5-437b-a617-8198d61b5a05","deleted":false,"title":"stdout","description":"","mimeType":"text/plain","dataId":"output"}],"parameters":[],"executor":"commandline","blobs":[]},"parameters":{},"inputs":{},"outputs":{"output":"a517f682-bcba-498e-9603-1c42b70b6a95"},"outputsToolData":{"output":null},"inputsToolData":{}}]}
25-Feb-2014 01:14:24 01:14:24,941  INFO                                                  /:  67 - Closing Spring root WebApplicationContext
25-Feb-2014 01:14:24 01:14:24,941  INFO ework.web.context.support.XmlWebApplicationContext:1025 - Closing Root WebApplicationContext: startup date [Tue Feb 25 01:14:24 CST 2014]; root of context hierarchy
25-Feb-2014 01:14:24 01:14:24,942  INFO k.beans.factory.support.DefaultListableBeanFactory: 433 - Destroying singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@cb8c5d9: defining beans [engine,applicationContextProvider,fileStorage,eventBus,entityManagerFactory,transactionManager,dataSource,personDAO,accountDAO,datasetDAO,pagingAndSortingAndDeleteRepository,fileDescriptorDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#0,org.springframework.dao.annotation.PersistenceExceptionTranslationPostProcessor#0,org.springframework.orm.jpa.support.PersistenceAnnotationBeanPostProcessor#0,logFileDAO,workflowToolDataDAO,workflowStepDAO,executionDAO,workflowToolParameterDAO,workflowToolDAO,workflowDAO,hPCJobInfoDAO,org.springframework.data.repository.core.support.RepositoryInterfaceAwareBeanPostProcessor#1]; root of factory hierarchy
25-Feb-2014 01:14:24 01:14:24,947  INFO ork.orm.jpa.LocalContainerEntityManagerFactoryBean: 441 - Closing JPA EntityManagerFactory for persistence unit 'default'
25-Feb-2014 01:14:24 Exception in thread "EngineThread" java.lang.IllegalStateException: BeanFactory not initialized or already closed - call 'refresh' before accessing beans via the ApplicationContext
25-Feb-2014 01:14:24         at org.springframework.context.support.AbstractRefreshableApplicationContext.getBeanFactory(AbstractRefreshableApplicationContext.java:172)
25-Feb-2014 01:14:24         at org.springframework.context.support.AbstractApplicationContext.getBean(AbstractApplicationContext.java:1098)
25-Feb-2014 01:14:24         at edu.illinois.ncsa.springdata.SpringData.getTransaction(SpringData.java:87)
25-Feb-2014 01:14:24         at edu.illinois.ncsa.cyberintegrator.Engine$WorkerThread.run(Engine.java:446)
25-Feb-2014 01:14:25 Jetty server stopped
25-Feb-2014 01:14:25 Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.878 sec
25-Feb-2014 01:14:25 01:14:25,051 DEBUG           edu.illinois.ncsa.springdata.Transaction:  65 - main
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 pool-1-thread-1
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 1726271323@qtp-664739753-0
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 EngineThread
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 EngineThread
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 EngineThread
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 74642793@qtp-1900502553-0
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 EngineThread
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 EngineThread
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25 EngineThread
25-Feb-2014 01:14:25         There are 0 open transactions :
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25 Results :
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25 Tests run: 3, Failures: 0, Errors: 0, Skipped: 0
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25 [INFO]
25-Feb-2014 01:14:25 [INFO] --- maven-jar-plugin:2.3.2:jar (default-jar) @ cyberintegrator-service ---
25-Feb-2014 01:14:25 [INFO]                                                                         
25-Feb-2014 01:14:25 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:25 [INFO] Building cyberintegrator-webapp 3.0.0-SNAPSHOT
25-Feb-2014 01:14:25 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:25 [INFO]
25-Feb-2014 01:14:25 [INFO] --- maven-resources-plugin:2.5:resources (default-resources) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:25 [debug] execute contextualize
25-Feb-2014 01:14:25 [INFO] Using 'UTF-8' encoding to copy filtered resources.
25-Feb-2014 01:14:25 [INFO] Copying 1 resource
25-Feb-2014 01:14:25 [INFO]
25-Feb-2014 01:14:25 [INFO] --- maven-compiler-plugin:2.3.2:compile (default-compile) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:25 [INFO] Nothing to compile - all classes are up to date
25-Feb-2014 01:14:25 [INFO]
25-Feb-2014 01:14:25 [INFO] --- maven-resources-plugin:2.5:testResources (default-testResources) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:25 [debug] execute contextualize
25-Feb-2014 01:14:25 [INFO] Using 'UTF-8' encoding to copy filtered resources.
25-Feb-2014 01:14:25 [INFO] Copying 1 resource
25-Feb-2014 01:14:25 [INFO]
25-Feb-2014 01:14:25 [INFO] --- maven-compiler-plugin:2.3.2:testCompile (default-testCompile) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:25 [INFO] Nothing to compile - all classes are up to date
25-Feb-2014 01:14:25 [INFO]
25-Feb-2014 01:14:25 [INFO] --- maven-surefire-plugin:2.10:test (default-test) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:25 [INFO] Surefire report directory: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-webapp/target/surefire-reports
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25 -------------------------------------------------------
25-Feb-2014 01:14:25 T E S T S
25-Feb-2014 01:14:25 -------------------------------------------------------
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25 Results :
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25 Tests run: 0, Failures: 0, Errors: 0, Skipped: 0
25-Feb-2014 01:14:25
25-Feb-2014 01:14:25 [INFO]
25-Feb-2014 01:14:25 [INFO] --- maven-war-plugin:2.1.1:war (default-war) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:25 [INFO] Packaging webapp
25-Feb-2014 01:14:25 [INFO] Assembling webapp [cyberintegrator-webapp] in [/home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-webapp/target/cyberintegrator-webapp-3.0.0-SNAPSHOT]
25-Feb-2014 01:14:25 [INFO] Processing war project
25-Feb-2014 01:14:25 [INFO] Copying webapp resources [/home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-webapp/src/main/webapp]
25-Feb-2014 01:14:25 [INFO] Webapp assembled in [124 msecs]
25-Feb-2014 01:14:26 [INFO] Building war: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-webapp/target/cyberintegrator-webapp-3.0.0-SNAPSHOT.war
25-Feb-2014 01:14:27 [INFO] WEB-INF/web.xml already added, skipping
25-Feb-2014 01:14:28 [INFO]
25-Feb-2014 01:14:28 [INFO] --- maven-dependency-plugin:2.3:copy (default) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:28 [INFO] Configured Artifact: org.mortbay.jetty:jetty-runner:8.1.5.v20120716:jar
25-Feb-2014 01:14:28 [INFO] org.mortbay.jetty:jetty-runner:8.1.5.v20120716:jar already exists in /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-webapp/target/dependency
25-Feb-2014 01:14:28 [INFO]
25-Feb-2014 01:14:28 [INFO] --- maven-assembly-plugin:2.2-beta-5:single (default) @ cyberintegrator-webapp ---
25-Feb-2014 01:14:28 [INFO] No files selected for line-ending conversion or filtering. Skipping: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-webapp/src/assembly/bin
25-Feb-2014 01:14:28 [INFO] Building zip: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-webapp/target/cyberintegrator-webapp-3.0.0-SNAPSHOT-bin.zip
25-Feb-2014 01:14:31 [INFO]                                                                         
25-Feb-2014 01:14:31 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:31 [INFO] Building cyberintegrator-editor 3.0.0-SNAPSHOT
25-Feb-2014 01:14:31 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:31 [INFO]
25-Feb-2014 01:14:31 [INFO] --- maven-resources-plugin:2.5:resources (default-resources) @ cyberintegrator-editor ---
25-Feb-2014 01:14:31 [debug] execute contextualize
25-Feb-2014 01:14:31 [INFO] Using 'UTF-8' encoding to copy filtered resources.
25-Feb-2014 01:14:31 [INFO] Copying 1 resource
25-Feb-2014 01:14:31 [INFO]
25-Feb-2014 01:14:31 [INFO] --- maven-compiler-plugin:2.3.2:compile (default-compile) @ cyberintegrator-editor ---
25-Feb-2014 01:14:31 [INFO] Nothing to compile - all classes are up to date
25-Feb-2014 01:14:31 [INFO]
25-Feb-2014 01:14:31 [INFO] --- maven-resources-plugin:2.5:testResources (default-testResources) @ cyberintegrator-editor ---
25-Feb-2014 01:14:31 [debug] execute contextualize
25-Feb-2014 01:14:31 [INFO] Using 'UTF-8' encoding to copy filtered resources.
25-Feb-2014 01:14:31 [INFO] Copying 1 resource
25-Feb-2014 01:14:31 [INFO]
25-Feb-2014 01:14:31 [INFO] --- maven-compiler-plugin:2.3.2:testCompile (default-testCompile) @ cyberintegrator-editor ---
25-Feb-2014 01:14:31 [INFO] Nothing to compile - all classes are up to date
25-Feb-2014 01:14:31 [INFO]
25-Feb-2014 01:14:31 [INFO] --- maven-surefire-plugin:2.10:test (default-test) @ cyberintegrator-editor ---
25-Feb-2014 01:14:31 [INFO] Surefire report directory: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-editor/target/surefire-reports
25-Feb-2014 01:14:31
25-Feb-2014 01:14:31 -------------------------------------------------------
25-Feb-2014 01:14:31 T E S T S
25-Feb-2014 01:14:31 -------------------------------------------------------
25-Feb-2014 01:14:31
25-Feb-2014 01:14:31 Results :
25-Feb-2014 01:14:31
25-Feb-2014 01:14:31 Tests run: 0, Failures: 0, Errors: 0, Skipped: 0
25-Feb-2014 01:14:31
25-Feb-2014 01:14:31 [INFO]
25-Feb-2014 01:14:31 [INFO] --- maven-war-plugin:2.1.1:war (default-war) @ cyberintegrator-editor ---
25-Feb-2014 01:14:31 [INFO] Packaging webapp
25-Feb-2014 01:14:31 [INFO] Assembling webapp [cyberintegrator-editor] in [/home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-editor/target/cyberintegrator-editor-3.0.0-SNAPSHOT]
25-Feb-2014 01:14:31 [INFO] Processing war project
25-Feb-2014 01:14:31 [INFO] Copying webapp resources [/home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-editor/src/main/webapp]
25-Feb-2014 01:14:31 [INFO] Webapp assembled in [190 msecs]
25-Feb-2014 01:14:31 [INFO] Building war: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-editor/target/cyberintegrator-editor-3.0.0-SNAPSHOT.war
25-Feb-2014 01:14:32 [INFO] WEB-INF/web.xml already added, skipping
25-Feb-2014 01:14:32 [INFO]
25-Feb-2014 01:14:32 [INFO] --- maven-dependency-plugin:2.3:copy (default) @ cyberintegrator-editor ---
25-Feb-2014 01:14:32 [INFO] Configured Artifact: org.mortbay.jetty:jetty-runner:8.1.5.v20120716:jar
25-Feb-2014 01:14:32 [INFO] org.mortbay.jetty:jetty-runner:8.1.5.v20120716:jar already exists in /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-editor/target/dependency
25-Feb-2014 01:14:32 [INFO]
25-Feb-2014 01:14:32 [INFO] --- maven-assembly-plugin:2.2-beta-5:single (default) @ cyberintegrator-editor ---
25-Feb-2014 01:14:32 [INFO] No files selected for line-ending conversion or filtering. Skipping: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-editor/src/assembly/bin
25-Feb-2014 01:14:32 [INFO] Building zip: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-editor/target/cyberintegrator-editor-3.0.0-SNAPSHOT-bin.zip
25-Feb-2014 01:14:33 [INFO]                                                                         
25-Feb-2014 01:14:33 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:33 [INFO] Building cyberintegrator-tool-creator 3.0.0-SNAPSHOT
25-Feb-2014 01:14:33 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:33 [INFO]
25-Feb-2014 01:14:33 [INFO] --- maven-resources-plugin:2.5:resources (default-resources) @ cyberintegrator-tool-creator ---
25-Feb-2014 01:14:33 [debug] execute contextualize
25-Feb-2014 01:14:33 [INFO] Using 'UTF-8' encoding to copy filtered resources.
25-Feb-2014 01:14:33 [INFO] Copying 3 resources
25-Feb-2014 01:14:33 [INFO]
25-Feb-2014 01:14:33 [INFO] --- maven-compiler-plugin:2.3.2:compile (default-compile) @ cyberintegrator-tool-creator ---
25-Feb-2014 01:14:33 [INFO] Nothing to compile - all classes are up to date
25-Feb-2014 01:14:33 [INFO]
25-Feb-2014 01:14:33 [INFO] --- maven-resources-plugin:2.5:testResources (default-testResources) @ cyberintegrator-tool-creator ---
25-Feb-2014 01:14:33 [debug] execute contextualize
25-Feb-2014 01:14:33 [INFO] Using 'UTF-8' encoding to copy filtered resources.
25-Feb-2014 01:14:33 [INFO] Copying 1 resource
25-Feb-2014 01:14:33 [INFO]
25-Feb-2014 01:14:33 [INFO] --- maven-compiler-plugin:2.3.2:testCompile (default-testCompile) @ cyberintegrator-tool-creator ---
25-Feb-2014 01:14:33 [INFO] Nothing to compile - all classes are up to date
25-Feb-2014 01:14:33 [INFO]
25-Feb-2014 01:14:33 [INFO] --- maven-surefire-plugin:2.10:test (default-test) @ cyberintegrator-tool-creator ---
25-Feb-2014 01:14:33 [INFO] Surefire report directory: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-tool-creator/target/surefire-reports
25-Feb-2014 01:14:33
25-Feb-2014 01:14:33 -------------------------------------------------------
25-Feb-2014 01:14:33 T E S T S
25-Feb-2014 01:14:33 -------------------------------------------------------
25-Feb-2014 01:14:33
25-Feb-2014 01:14:33 Results :
25-Feb-2014 01:14:33
25-Feb-2014 01:14:33 Tests run: 0, Failures: 0, Errors: 0, Skipped: 0
25-Feb-2014 01:14:33
25-Feb-2014 01:14:33 [INFO]
25-Feb-2014 01:14:33 [INFO] --- maven-jar-plugin:2.3.2:jar (default-jar) @ cyberintegrator-tool-creator ---
25-Feb-2014 01:14:33 [INFO]
25-Feb-2014 01:14:33 [INFO] --- maven-assembly-plugin:2.2-beta-5:single (default) @ cyberintegrator-tool-creator ---
25-Feb-2014 01:14:35 [INFO] Building zip: /home/opensource/data/bamboo/xml-data/build-dir/CI-SERVER-CORE/cyberintegrator-tool-creator/target/cyberintegrator-tool-creator-3.0.0-SNAPSHOT-bin.zip
25-Feb-2014 01:14:36 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:36 [INFO] Reactor Summary:
25-Feb-2014 01:14:36 [INFO]
25-Feb-2014 01:14:36 [INFO] cyberintegrator ................................... SUCCESS [0.002s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-domain ............................ SUCCESS [1.229s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-springdata ........................ SUCCESS [7.100s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-core .............................. SUCCESS [12.191s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-executor-java-tool ................ SUCCESS [0.144s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-executor-java ..................... SUCCESS [3.811s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-tool-example ...................... SUCCESS [0.146s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-executor-commandline .............. SUCCESS [4.164s]
25-Feb-2014 01:14:36 [INFO] gondola ........................................... SUCCESS [0.445s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-executor-hpc ...................... SUCCESS [0.220s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-service-client .................... SUCCESS [0.227s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-service ........................... SUCCESS [18.412s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-webapp ............................ SUCCESS [5.976s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-editor ............................ SUCCESS [2.215s]
25-Feb-2014 01:14:36 [INFO] cyberintegrator-tool-creator ...................... SUCCESS [3.002s]
25-Feb-2014 01:14:36 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:36 [INFO] BUILD SUCCESS
25-Feb-2014 01:14:36 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:36 [INFO] Total time: 59.956s
25-Feb-2014 01:14:36 [INFO] Finished at: Tue Feb 25 01:14:36 CST 2014
25-Feb-2014 01:14:36 [INFO] Final Memory: 17M/214M
25-Feb-2014 01:14:36 [INFO] ------------------------------------------------------------------------
25-Feb-2014 01:14:36 Parsing test results...
25-Feb-2014 01:14:36 Finished task 'package'
25-Feb-2014 01:14:36 Running post build plugin 'NCover Results Collector'
25-Feb-2014 01:14:36 Running post build plugin 'Clover Results Collector'
25-Feb-2014 01:14:36 Running post build plugin 'Artifact Copier'
25-Feb-2014 01:14:36 Publishing an artifact: cyberintegrator-webapp.zip
25-Feb-2014 01:14:36 Finished publishing of artifact Shared artifact: [cyberintegrator-webapp.zip], pattern: [cyberintegrator-webapp*-bin.zip] anchored at: [cyberintegrator-webapp/target] in 0s
25-Feb-2014 01:14:36 Publishing an artifact: cyberintegrator-webapp.war
25-Feb-2014 01:14:36 Finished publishing of artifact Shared artifact: [cyberintegrator-webapp.war], pattern: [cyberintegrator-webapp*.war] anchored at: [cyberintegrator-webapp/target] in 0s
25-Feb-2014 01:14:36 Publishing an artifact: cyberintegrator-editor.war
25-Feb-2014 01:14:36 Finished publishing of artifact Shared artifact: [cyberintegrator-editor.war], pattern: [cyberintegrator-editor*.war] anchored at: [cyberintegrator-editor/target] in 0s
25-Feb-2014 01:14:36 Publishing an artifact: cyberintegrator-editor.zip
25-Feb-2014 01:14:36 Finished publishing of artifact Shared artifact: [cyberintegrator-editor.zip], pattern: [cyberintegrator-editor*.zip] anchored at: [cyberintegrator-editor/target] in 0s
25-Feb-2014 01:14:36 Publishing an artifact: cyberintegrator-tool-creator.zip
25-Feb-2014 01:14:36 Finished publishing of artifact Shared artifact: [cyberintegrator-tool-creator.zip], pattern: [cyberintegrator-tool-creator*-bin.zip] anchored at: [cyberintegrator-tool-creator/target] in 0s
25-Feb-2014 01:14:36 Finalising the build...
25-Feb-2014 01:14:36 Stopping timer.
25-Feb-2014 01:14:36 Build CI-SERVER-CORE-110 completed.
25-Feb-2014 01:14:36 Running on server: post build plugin 'NCover Results Collector'
25-Feb-2014 01:14:36 Running on server: post build plugin 'Clover Delta Calculator'
25-Feb-2014 01:14:36 Running on server: post build plugin 'Build Hanging Detection Configuration'
25-Feb-2014 01:14:36 Running on server: post build plugin 'Maven Dependencies Postprocessor'
25-Feb-2014 01:14:36 All post build plugins have finished
25-Feb-2014 01:14:36 Generating build results summary...
25-Feb-2014 01:14:36 Saving build results to disk...
25-Feb-2014 01:14:36 Indexing build results...
25-Feb-2014 01:14:36 Finished building CI-SERVER-CORE-110.