Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization.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.0015/0.0015, allocations: 104.3 kB / 19.71 MB, free: 2.145 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.001501/0.001501, allocations: 213.7 kB / 23 MB, free: 4.973 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.271/1.271, allocations: 230.6 MB / 256.8 MB, free: 7.816 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.714/2.714, allocations: 0.49 GB / 0.7958 GB, free: 35.51 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/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(Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|valOpePoi.m_flow|valKv.m_flow|valCv.m_flow|valAv.m_flow",fileNamePrefix="Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization")
translateModel(Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|valOpePoi.m_flow|valKv.m_flow|valCv.m_flow|valAv.m_flow",fileNamePrefix="Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.081e-05/1.081e-05, allocations: 2.281 kB / 1.155 GB, free: 25.2 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization): time 0.02147/0.02148, allocations: 28.45 MB / 1.183 GB, free: 6.109 MB / 0.9044 GB
Notification: Performance of NFInst.instExpressions: time 0.01018/0.03167, allocations: 9.979 MB / 1.193 GB, free: 15.38 MB / 0.92 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007841/0.03245, allocations: 39.56 kB / 1.193 GB, free: 15.36 MB / 0.92 GB
Notification: Performance of NFTyping.typeComponents: time 0.0009586/0.03341, allocations: 386.2 kB / 1.193 GB, free: 15.13 MB / 0.92 GB
Notification: Performance of NFTyping.typeBindings: time 0.002728/0.03614, allocations: 1.2 MB / 1.194 GB, free: 14.43 MB / 0.92 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002076/0.03821, allocations: 0.869 MB / 1.195 GB, free: 13.99 MB / 0.92 GB
Notification: Performance of NFFlatten.flatten: time 0.002596/0.04081, allocations: 2.371 MB / 1.197 GB, free: 12.9 MB / 0.92 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009959/0.0418, allocations: 0.7159 MB / 1.198 GB, free: 12.58 MB / 0.92 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001913/0.04372, allocations: 1.208 MB / 1.199 GB, free: 12.06 MB / 0.92 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0007819/0.0445, allocations: 0.6293 MB / 1.2 GB, free: 11.79 MB / 0.92 GB
Notification: Performance of NFPackage.collectConstants: time 8.919e-05/0.04459, allocations: 51.59 kB / 1.2 GB, free: 11.79 MB / 0.92 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0009421/0.04553, allocations: 0.5172 MB / 1.2 GB, free: 11.64 MB / 0.92 GB
Notification: Performance of combineBinaries: time 0.001349/0.04688, allocations: 1.636 MB / 1.202 GB, free: 10.59 MB / 0.92 GB
Notification: Performance of replaceArrayConstructors: time 0.000694/0.04757, allocations: 1.054 MB / 1.203 GB, free: 9.871 MB / 0.92 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001095/0.04768, allocations: 78.66 kB / 1.203 GB, free: 9.871 MB / 0.92 GB
Notification: Performance of FrontEnd: time 8.981e-05/0.04777, allocations: 32.11 kB / 1.203 GB, free: 9.859 MB / 0.92 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 117 (105)
 * Number of variables: 117 (99)
Notification: Performance of [SIM] Bindings: time 0.003317/0.05109, allocations: 3.534 MB / 1.207 GB, free: 7.512 MB / 0.92 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0003628/0.05145, allocations: 322.8 kB / 1.207 GB, free: 7.328 MB / 0.92 GB
Notification: Performance of [SIM] Early Inline: time 0.00142/0.05287, allocations: 1.405 MB / 1.208 GB, free: 6.488 MB / 0.92 GB
Notification: Performance of [SIM] Simplify 1: time 0.0004742/0.05335, allocations: 336.9 kB / 1.209 GB, free: 6.27 MB / 0.92 GB
Notification: Performance of [SIM] Alias: time 0.003051/0.0564, allocations: 2.272 MB / 1.211 GB, free: 4.93 MB / 0.92 GB
Notification: Performance of [SIM] Simplify 2: time 0.0003465/0.05674, allocations: 260.2 kB / 1.211 GB, free: 4.762 MB / 0.92 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001554/0.0569, allocations: 141.7 kB / 1.211 GB, free: 4.648 MB / 0.92 GB
Notification: Performance of [SIM] Detect States: time 0.000296/0.0572, allocations: 291 kB / 1.211 GB, free: 4.406 MB / 0.92 GB
Notification: Performance of [SIM] Events: time 8.864e-05/0.05728, allocations: 47.36 kB / 1.211 GB, free: 4.383 MB / 0.92 GB
Notification: Performance of [SIM] Partitioning: time 0.000383/0.05767, allocations: 341.8 kB / 1.212 GB, free: 4.203 MB / 0.92 GB
Notification: Performance of [SIM] Causalize: time 0.0009446/0.05861, allocations: 0.7751 MB / 1.213 GB, free: 3.98 MB / 0.92 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0006786/0.05929, allocations: 0.707 MB / 1.213 GB, free: 3.617 MB / 0.92 GB
Notification: Performance of [INI] Simplify: time 0.001307/0.0606, allocations: 0.8961 MB / 1.214 GB, free: 3.113 MB / 0.92 GB
Notification: Performance of [INI] Inline: time 0.001269/0.06187, allocations: 1.295 MB / 1.215 GB, free: 2.398 MB / 0.92 GB
Notification: Performance of [INI] Partitioning: time 6.842e-05/0.06193, allocations: 37.94 kB / 1.215 GB, free: 2.379 MB / 0.92 GB
Notification: Performance of [INI] Cleanup: time 0.0003017/0.06224, allocations: 306.9 kB / 1.216 GB, free: 2.199 MB / 0.92 GB
Notification: Performance of [INI] Causalize: time 0.004308/0.06654, allocations: 3.444 MB / 1.219 GB, free: 1.453 MB / 0.92 GB
Notification: Performance of [INI] Tearing: time 7.749e-05/0.06662, allocations: 114.9 kB / 1.219 GB, free: 1.367 MB / 0.92 GB
Notification: Performance of [SIM] Initialization: time 6.71e-07/0.06662, allocations: 0.7812 kB / 1.219 GB, free: 1.367 MB / 0.92 GB
Notification: Performance of [SIM] Remove Dummies: time 6.923e-06/0.06663, allocations: 0.7812 kB / 1.219 GB, free: 1.367 MB / 0.92 GB
Notification: Performance of [SIM] Tearing: time 1.613e-05/0.06664, allocations: 27 kB / 1.219 GB, free: 1.348 MB / 0.92 GB
Notification: Performance of [SIM] Categorize: time 1.114e-05/0.06666, allocations: 3.062 kB / 1.219 GB, free: 1.348 MB / 0.92 GB
Notification: Performance of [SIM] Solve: time 0.002436/0.06909, allocations: 2.356 MB / 1.221 GB, free: 15.82 MB / 0.9356 GB
Notification: Performance of [SIM] Jacobian: time 0.000629/0.06972, allocations: 0.8271 MB / 1.222 GB, free: 14.9 MB / 0.9356 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 2
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 1
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 0 (0) {}
 * Number of discrete states: .................... 0 (0) {}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 2 (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: ........... 39 (scalar:39, array:0, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 4 (resizable: 4, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 0, nonlinear:4)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 100 (scalar:98, array:2, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 4 (resizable: 4, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 4 (linear: 0, nonlinear:4)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 104 (scalar:102, array:2, record:0)
 * Number of multi strong components: ............ 0 (algorithm:0, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 4 (resizable: 4, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 0 (linear: 0, nonlinear:0)
Notification: Performance of backend: time 7.744e-05/0.0698, allocations: 60.62 kB / 1.222 GB, free: 14.84 MB / 0.9356 GB
Notification: Performance of SimCode: time 0.003881/0.07368, allocations: 2.767 MB / 1.225 GB, free: 13.59 MB / 0.9356 GB
Notification: Performance of Templates: time 0.01335/0.08703, allocations: 7.929 MB / 1.233 GB, free: 11.04 MB / 0.9356 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization.pipe ; mkfifo Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization.pipe >> ../files/Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization.sim & ./Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Actuators.Valves.Validation.TwoWayValveParameterization.pipe 2>&1) [Timeout 400]
[Calling os._exit(0), Time elapsed: 7.440112580079585]
Failed to read output from testmodel.py, exit status != 0:
0.09373802691698074 0.10678586300000001 0.056286524000000004
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f04ef702f20>