Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001561/0.001561, allocations: 96.41 kB / 20.52 MB, free: 1.152 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002351/0.002351, allocations: 214.1 kB / 23.81 MB, free: 4.344 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.414/1.414, allocations: 230.7 MB / 257.6 MB, free: 7.707 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.951/0.951, allocations: 149.9 MB / 463.9 MB, free: 10.27 MB / 366.1 MB
"
[Timeout remaining time 179]
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime")
translateModel(IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime,tolerance=1e-06,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.46e-05/2.46e-05, allocations: 2.281 kB / 0.6424 GB, free: 9.52 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime): time 0.004326/0.004351, allocations: 2.355 MB / 0.6447 GB, free: 7.172 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.003416/0.007766, allocations: 1.668 MB / 0.6464 GB, free: 5.504 MB / 478.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0003145/0.008081, allocations: 9.25 kB / 0.6464 GB, free: 5.496 MB / 478.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0006731/0.008754, allocations: 324 kB / 0.6467 GB, free: 5.18 MB / 478.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.000961/0.009715, allocations: 416 kB / 0.6471 GB, free: 4.773 MB / 478.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0006497/0.01036, allocations: 291.4 kB / 0.6474 GB, free: 4.488 MB / 478.1 MB
Notification: Performance of NFFlatten.flatten: time 0.001307/0.01167, allocations: 0.9592 MB / 0.6483 GB, free: 3.539 MB / 478.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0002257/0.0119, allocations: 49.89 kB / 0.6483 GB, free: 3.492 MB / 478.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0008309/0.01273, allocations: 459.7 kB / 0.6488 GB, free: 3.043 MB / 478.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0005877/0.01332, allocations: 324.2 kB / 0.6491 GB, free: 2.727 MB / 478.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001389/0.01346, allocations: 32 kB / 0.6491 GB, free: 2.695 MB / 478.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00028/0.01374, allocations: 91.95 kB / 0.6492 GB, free: 2.605 MB / 478.1 MB
Notification: Performance of combineBinaries: time 0.001023/0.01476, allocations: 1.053 MB / 0.6502 GB, free: 1.543 MB / 478.1 MB
Notification: Performance of replaceArrayConstructors: time 0.0006917/0.01545, allocations: 0.7057 MB / 0.6509 GB, free: 0.8281 MB / 478.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001189/0.01557, allocations: 24 kB / 0.6509 GB, free: 0.8047 MB / 478.1 MB
Notification: Performance of FrontEnd: time 5.836e-05/0.01563, allocations: 16.86 kB / 0.651 GB, free: 0.7891 MB / 478.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 25 (25)
 * Number of variables: 25 (25)
Notification: Performance of [SIM] Bindings: time 0.002625/0.01825, allocations: 2.299 MB / 0.6532 GB, free: 14.35 MB / 494.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.000381/0.01863, allocations: 201.5 kB / 0.6534 GB, free: 14.15 MB / 494.1 MB
Notification: Performance of [SIM] Early Inline: time 0.001114/0.01975, allocations: 0.8269 MB / 0.6542 GB, free: 13.29 MB / 494.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.0003802/0.02013, allocations: 198.8 kB / 0.6544 GB, free: 13.05 MB / 494.1 MB
Notification: Performance of [SIM] Alias: time 0.001495/0.02162, allocations: 0.8482 MB / 0.6552 GB, free: 12.07 MB / 494.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.0003076/0.02193, allocations: 189.4 kB / 0.6554 GB, free: 11.84 MB / 494.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.0001722/0.0221, allocations: 114.2 kB / 0.6555 GB, free: 11.7 MB / 494.1 MB
Notification: Performance of [SIM] Detect States: time 0.0005049/0.02261, allocations: 304.5 kB / 0.6558 GB, free: 11.36 MB / 494.1 MB
Notification: Performance of [SIM] Events: time 0.0001492/0.02276, allocations: 80.8 kB / 0.6559 GB, free: 11.28 MB / 494.1 MB
Notification: Performance of [SIM] Partitioning: time 0.0003991/0.02315, allocations: 284.3 kB / 0.6561 GB, free: 10.96 MB / 494.1 MB
Notification: Performance of [SIM] Causalize: time 0.0007221/0.02388, allocations: 461.1 kB / 0.6566 GB, free: 10.48 MB / 494.1 MB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0005866/0.02446, allocations: 0.5383 MB / 0.6571 GB, free: 9.938 MB / 494.1 MB
Notification: Performance of [INI] Simplify: time 0.007534/0.032, allocations: 1.336 MB / 0.6584 GB, free: 8.711 MB / 494.1 MB
Notification: Performance of [INI] Inline: time 0.001453/0.03345, allocations: 1.147 MB / 0.6595 GB, free: 7.562 MB / 494.1 MB
Notification: Performance of [INI] Partitioning: time 9.814e-05/0.03355, allocations: 35.98 kB / 0.6596 GB, free: 7.516 MB / 494.1 MB
Notification: Performance of [INI] Cleanup: time 0.000428/0.03398, allocations: 199.8 kB / 0.6598 GB, free: 7.32 MB / 494.1 MB
Notification: Performance of [INI] Causalize: time 0.005733/0.03971, allocations: 3.179 MB / 0.6629 GB, free: 4.102 MB / 494.1 MB
Notification: Performance of [INI] Tearing: time 6.765e-05/0.03978, allocations: 48 kB / 0.6629 GB, free: 4.055 MB / 494.1 MB
Notification: Performance of [SIM] Initialization: time 1.673e-06/0.03978, allocations: 0 / 0.6629 GB, free: 4.055 MB / 494.1 MB
Notification: Performance of [SIM] DAE-Mode: time 0.0002352/0.04001, allocations: 112.3 kB / 0.663 GB, free: 3.91 MB / 494.1 MB
Notification: Performance of [SIM] Remove Dummies: time 9.118e-06/0.04002, allocations: 4 kB / 0.663 GB, free: 3.906 MB / 494.1 MB
Notification: Performance of [SIM] Tearing: time 1.96e-05/0.04004, allocations: 27.94 kB / 0.6631 GB, free: 3.879 MB / 494.1 MB
Notification: Performance of [SIM] Categorize: time 2.277e-05/0.04007, allocations: 7.984 kB / 0.6631 GB, free: 3.871 MB / 494.1 MB
Notification: Performance of [SIM] Solve: time 0.001372/0.04144, allocations: 0.8352 MB / 0.6639 GB, free: 3.039 MB / 494.1 MB
Notification: Performance of [SIM] Jacobian: time 0.0006662/0.0421, allocations: 0.8615 MB / 0.6647 GB, free: 2.012 MB / 494.1 MB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 0
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 5
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 0
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 0 (0) {}
 * Number of discrete states: .................... 10 (10) {timTabLinCon.tab.nextTimeEvent, timTabLinCon.tab.nextTimeEventScaled, timTabCon.tab.nextTimeEvent, timTabCon.tab.nextTimeEventScaled, timTabLinDer.tab.nextTimeEvent, timTabLinDer.tab.nextTimeEventScaled, timTabLinHol.tab.nextTimeEvent, timTabLinHol.tab.nextTimeEventScaled, timTabLin.tab.nextTimeEvent, timTabLin.tab.nextTimeEventScaled}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 10 (10) {$SEV_4, $SEV_3, $SEV_2, $SEV_1, $SEV_0, $TEV_4, $TEV_3, $TEV_2, $TEV_1, $TEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 20 (scalar:20, array:0, record:0)
 * Number of multi strong components: ............ 10 (algorithm:0, when:10, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 88 (scalar:78, array:10, record:0)
 * Number of multi strong components: ............ 10 (algorithm:10, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 0.0001444/0.04225, allocations: 51.33 kB / 0.6648 GB, free: 1.969 MB / 494.1 MB
Notification: Performance of SimCode: time 0.005937/0.04819, allocations: 2.886 MB / 0.6676 GB, free: 15.27 MB / 0.4981 GB
Notification: Performance of Templates: time 0.01132/0.05951, allocations: 5.06 MB / 0.6725 GB, free: 10.28 MB / 0.4981 GB
"
[Timeout remaining time 660]
make -j1 -f IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime.makefile [Timeout 660]
(rm -f IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime.pipe ; mkfifo IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime.pipe >> ../files/IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime.sim & ./IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Controls.OBC.CDL.Reals.Sources.Validation.TimeTableNegativeStartTime.pipe 2>&1) [Timeout 480]
[Calling os._exit(0), Time elapsed: 5.48970149300294]
Failed to read output from testmodel.py, exit status != 0:
0.06825294101145118 0.08249696200000001 0.063901681
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fa0dd3b2fb0>