Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential")
translateModel(IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001689/0.001689, allocations: 116.4 kB / 17.09 MB, free: 5.957 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001929/0.001929, allocations: 194.9 kB / 18.03 MB, free: 5.031 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.514/1.514, allocations: 222.9 MB / 241.7 MB, free: 15.08 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.8035/0.8035, allocations: 126.1 MB / 417.9 MB, free: 12.82 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001233/0.001233, allocations: 60.98 kB / 0.5737 GB, free: 27.27 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1923/0.1935, allocations: 78.71 MB / 0.6506 GB, free: 4.094 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential): time 0.7344/0.9279, allocations: 174.6 MB / 0.8211 GB, free: 10.74 MB / 0.5919 GB
Notification: Performance of NFInst.instExpressions: time 0.006663/0.9347, allocations: 3.309 MB / 0.8244 GB, free: 9.109 MB / 0.5919 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001474/0.9362, allocations: 18.03 kB / 0.8244 GB, free: 9.102 MB / 0.5919 GB
Notification: Performance of NFTyping.typeComponents: time 0.001291/0.9375, allocations: 354.7 kB / 0.8247 GB, free: 8.84 MB / 0.5919 GB
Notification: Performance of NFTyping.typeBindings: time 0.003444/0.941, allocations: 1.107 MB / 0.8258 GB, free: 8.133 MB / 0.5919 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003124/0.9441, allocations: 1.001 MB / 0.8268 GB, free: 7.555 MB / 0.5919 GB
Notification: Performance of NFFlatten.flatten: time 0.002459/0.9466, allocations: 1.603 MB / 0.8283 GB, free: 6.68 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008385/0.9474, allocations: 0.6173 MB / 0.829 GB, free: 6.285 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00142/0.9489, allocations: 0.764 MB / 0.8297 GB, free: 5.879 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0007507/0.9496, allocations: 0.5609 MB / 0.8302 GB, free: 5.551 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001315/0.9498, allocations: 70.22 kB / 0.8303 GB, free: 5.551 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002143/0.9519, allocations: 0.9587 MB / 0.8312 GB, free: 5.129 MB / 0.5919 GB
Notification: Performance of NFScalarize.scalarize: time 0.0003158/0.9523, allocations: 272.9 kB / 0.8315 GB, free: 4.938 MB / 0.5919 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004486/0.9527, allocations: 427.3 kB / 0.8319 GB, free: 4.648 MB / 0.5919 GB
Notification: Performance of NFConvertDAE.convert: time 0.00188/0.9546, allocations: 1.211 MB / 0.8331 GB, free: 3.902 MB / 0.5919 GB
Notification: Performance of FrontEnd - DAE generated: time 5.27e-06/0.9546, allocations: 3.938 kB / 0.8331 GB, free: 3.898 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 2.374e-06/0.9546, allocations: 5.844 kB / 0.8331 GB, free: 3.895 MB / 0.5919 GB
Notification: Performance of Transformations before backend: time 1.137e-05/0.9546, allocations: 0 / 0.8331 GB, free: 3.895 MB / 0.5919 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 89
 * Number of variables: 89
Notification: Performance of Generate backend data structure: time 0.002938/0.9576, allocations: 1.297 MB / 0.8344 GB, free: 2.895 MB / 0.5919 GB
Notification: Performance of prepare preOptimizeDAE: time 4.597e-05/0.9576, allocations: 10.75 kB / 0.8344 GB, free: 2.891 MB / 0.5919 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006219/0.9583, allocations: 143.6 kB / 0.8345 GB, free: 2.82 MB / 0.5919 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001475/0.9598, allocations: 0.7525 MB / 0.8353 GB, free: 2.246 MB / 0.5919 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.945e-05/0.9598, allocations: 37.14 kB / 0.8353 GB, free: 2.227 MB / 0.5919 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 8.487e-05/0.9599, allocations: 44.47 kB / 0.8353 GB, free: 2.215 MB / 0.5919 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0008184/0.9607, allocations: 455.3 kB / 0.8358 GB, free: 1.941 MB / 0.5919 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.582e-05/0.9608, allocations: 3.938 kB / 0.8358 GB, free: 1.938 MB / 0.5919 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 3.786e-05/0.9608, allocations: 12.78 kB / 0.8358 GB, free: 1.93 MB / 0.5919 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.025e-05/0.9608, allocations: 19.78 kB / 0.8358 GB, free: 1.926 MB / 0.5919 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0007265/0.9616, allocations: 353.6 kB / 0.8361 GB, free: 1.766 MB / 0.5919 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.002579/0.9642, allocations: 1.91 MB / 0.838 GB, free: 132 kB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.000618/0.9648, allocations: 295.9 kB / 0.8383 GB, free: 15.98 MB / 0.6075 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0003237/0.9651, allocations: 168.7 kB / 0.8384 GB, free: 15.89 MB / 0.6075 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.000325/0.9655, allocations: 192 kB / 0.8386 GB, free: 15.7 MB / 0.6075 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.403e-05/0.9655, allocations: 36.5 kB / 0.8387 GB, free: 15.65 MB / 0.6075 GB
Notification: Performance of pre-optimization done (n=26): time 2.225e-06/0.9655, allocations: 0 / 0.8387 GB, free: 15.65 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=26): time 0.001912/0.9674, allocations: 0.6652 MB / 0.8393 GB, free: 15.26 MB / 0.6075 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.646e-05/0.9675, allocations: 54 kB / 0.8394 GB, free: 15.2 MB / 0.6075 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001289/0.9688, allocations: 0.8777 MB / 0.8402 GB, free: 14.71 MB / 0.6075 GB
Notification: Performance of collectPreVariables (initialization): time 5.025e-05/0.9688, allocations: 34.27 kB / 0.8403 GB, free: 14.68 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002693/0.9691, allocations: 333.9 kB / 0.8406 GB, free: 14.39 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 9.148e-05/0.9692, allocations: 103.8 kB / 0.8407 GB, free: 14.3 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001312/0.9693, allocations: 70.19 kB / 0.8407 GB, free: 14.26 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 0.0001334/0.9695, allocations: 320.5 kB / 0.841 GB, free: 13.94 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002882/0.9698, allocations: 126.5 kB / 0.8412 GB, free: 13.88 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004362/0.9702, allocations: 292.3 kB / 0.8414 GB, free: 13.62 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0005995/0.9708, allocations: 302 kB / 0.8417 GB, free: 13.47 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.645e-06/0.9708, allocations: 0 / 0.8417 GB, free: 13.47 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=30) (initialization): time 0.001049/0.9719, allocations: 471.6 kB / 0.8422 GB, free: 13.22 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 2.921e-05/0.9719, allocations: 8.75 kB / 0.8422 GB, free: 13.22 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.123e-06/0.972, allocations: 0 / 0.8422 GB, free: 13.22 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000372/0.9723, allocations: 53.97 kB / 0.8422 GB, free: 13.2 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005651/0.9729, allocations: 106.2 kB / 0.8423 GB, free: 13.16 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007928/0.9737, allocations: 1.156 MB / 0.8435 GB, free: 12 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007965/0.9745, allocations: 85.25 kB / 0.8436 GB, free: 11.96 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.73e-05/0.9746, allocations: 15.83 kB / 0.8436 GB, free: 11.95 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0004974/0.9751, allocations: 276.8 kB / 0.8438 GB, free: 11.77 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0004288/0.9755, allocations: 299.9 kB / 0.8441 GB, free: 11.51 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0005808/0.9761, allocations: 288.5 kB / 0.8444 GB, free: 11.36 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.764e-06/0.9761, allocations: 0 / 0.8444 GB, free: 11.36 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=30) (initialization_lambda0): time 0.0009485/0.9771, allocations: 436.9 kB / 0.8448 GB, free: 11.13 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 1.02e-05/0.9771, allocations: 5.25 kB / 0.8448 GB, free: 11.13 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.335e-06/0.9771, allocations: 240 / 0.8448 GB, free: 11.13 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001424/0.9773, allocations: 52.91 kB / 0.8449 GB, free: 11.09 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003835/0.9776, allocations: 77.72 kB / 0.8449 GB, free: 11.08 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001451/0.9791, allocations: 1.691 MB / 0.8466 GB, free: 9.359 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008988/0.98, allocations: 99.62 kB / 0.8467 GB, free: 9.309 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 2.944e-05/0.9801, allocations: 15.73 kB / 0.8467 GB, free: 9.301 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 3
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (27):
 * Single equations (assignments): 25
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.0001914/0.9803, allocations: 195.9 kB / 0.8469 GB, free: 9.109 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001265/0.9804, allocations: 78.72 kB / 0.847 GB, free: 9.066 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0009368/0.9813, allocations: 450.5 kB / 0.8474 GB, free: 8.809 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.769e-06/0.9813, allocations: 0 / 0.8474 GB, free: 8.809 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.968e-06/0.9814, allocations: 3.984 kB / 0.8474 GB, free: 8.805 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0002661/0.9816, allocations: 210.6 kB / 0.8476 GB, free: 8.609 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.697e-05/0.9817, allocations: 17.2 kB / 0.8476 GB, free: 8.598 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006271/0.9824, allocations: 41.72 kB / 0.8477 GB, free: 8.574 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.068e-05/0.9825, allocations: 18.06 kB / 0.8477 GB, free: 8.566 MB / 0.6075 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00114/0.9836, allocations: 0.5041 MB / 0.8482 GB, free: 8.258 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001149/0.9848, allocations: 0.7565 MB / 0.8489 GB, free: 7.766 MB / 0.6075 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0002999/0.9851, allocations: 154.2 kB / 0.8491 GB, free: 7.691 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.0009304/0.986, allocations: 0.6513 MB / 0.8497 GB, free: 7.332 MB / 0.6075 GB
Notification: Performance of Backend: time 5.41e-07/0.986, allocations: 0 / 0.8497 GB, free: 7.332 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.002316/0.9883, allocations: 0.7727 MB / 0.8504 GB, free: 6.883 MB / 0.6075 GB
Notification: Performance of SimCode: time 0.002571/0.9909, allocations: 1.844 MB / 0.8522 GB, free: 5.297 MB / 0.6075 GB
Notification: Performance of Templates: time 0.03041/1.021, allocations: 16.28 MB / 0.8681 GB, free: 5.176 MB / 0.6231 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential.sim & ./IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Actuators.Dampers.Examples.VAVBoxExponential.pipe 2>&1)