Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves.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.Valves.Examples.ThreeWayValves,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves")
translateModel(IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0009674/0.0009672, allocations: 106.8 kB / 16.41 MB, free: 6.434 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.001134/0.001134, allocations: 197.4 kB / 17.34 MB, free: 5.742 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.273/1.273, allocations: 222.9 MB / 241 MB, free: 15.18 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6835/0.6835, allocations: 115.3 MB / 406.5 MB, free: 6.195 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001126/0.001126, allocations: 63.5 kB / 0.5577 GB, free: 32.3 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1228/0.1239, allocations: 76.18 MB / 0.6321 GB, free: 4.43 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves): time 0.09706/0.221, allocations: 112.6 MB / 0.7421 GB, free: 3.426 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.3204/0.5414, allocations: 20.23 MB / 0.7618 GB, free: 30.65 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004464/0.546, allocations: 108.8 kB / 0.7619 GB, free: 30.65 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.003062/0.549, allocations: 1.275 MB / 0.7632 GB, free: 30.63 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.008727/0.5578, allocations: 3.698 MB / 0.7668 GB, free: 30.48 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007236/0.5651, allocations: 3.12 MB / 0.7698 GB, free: 30.38 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.01119/0.5763, allocations: 7.217 MB / 0.7769 GB, free: 30.37 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003643/0.58, allocations: 2.571 MB / 0.7794 GB, free: 30.03 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005852/0.5858, allocations: 2.893 MB / 0.7822 GB, free: 29.22 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003499/0.5894, allocations: 2.119 MB / 0.7843 GB, free: 28.43 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005043/0.5899, allocations: 253.6 kB / 0.7845 GB, free: 28.43 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003722/0.5936, allocations: 1.653 MB / 0.7861 GB, free: 27.96 MB / 0.5762 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005182/0.5941, allocations: 0.687 MB / 0.7868 GB, free: 27.55 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.001579/0.5957, allocations: 1.517 MB / 0.7883 GB, free: 26.61 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.004441/0.6002, allocations: 4.395 MB / 0.7926 GB, free: 24.37 MB / 0.5762 GB
Notification: Performance of FrontEnd - DAE generated: time 5.41e-06/0.6002, allocations: 3.938 kB / 0.7926 GB, free: 24.37 MB / 0.5762 GB
Notification: Performance of FrontEnd: time 1.463e-06/0.6002, allocations: 0 / 0.7926 GB, free: 24.37 MB / 0.5762 GB
Notification: Performance of Transformations before backend: time 4.271e-05/0.6003, allocations: 0 / 0.7926 GB, free: 24.37 MB / 0.5762 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 379
 * Number of variables: 379
Notification: Performance of Generate backend data structure: time 0.003946/0.6042, allocations: 3.227 MB / 0.7957 GB, free: 22.02 MB / 0.5762 GB
Notification: Performance of prepare preOptimizeDAE: time 3.32e-05/0.6042, allocations: 11.06 kB / 0.7958 GB, free: 22.02 MB / 0.5762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006165/0.6049, allocations: 323 kB / 0.7961 GB, free: 21.86 MB / 0.5762 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002726/0.6076, allocations: 2.205 MB / 0.7982 GB, free: 20.27 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.559e-05/0.6077, allocations: 129.3 kB / 0.7983 GB, free: 20.21 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000179/0.6079, allocations: 165.4 kB / 0.7985 GB, free: 20.16 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002179/0.6101, allocations: 1.608 MB / 0.8001 GB, free: 19.16 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.244e-05/0.6101, allocations: 14.84 kB / 0.8001 GB, free: 19.15 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001114/0.6102, allocations: 61.34 kB / 0.8001 GB, free: 19.1 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.975e-05/0.6103, allocations: 43.91 kB / 0.8002 GB, free: 19.1 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001621/0.6119, allocations: 1.151 MB / 0.8013 GB, free: 18.51 MB / 0.5762 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.007681/0.6196, allocations: 7.908 MB / 0.809 GB, free: 11.82 MB / 0.5762 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.000648/0.6202, allocations: 485.3 kB / 0.8095 GB, free: 11.57 MB / 0.5762 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004101/0.6207, allocations: 326.1 kB / 0.8098 GB, free: 11.41 MB / 0.5762 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004421/0.6211, allocations: 0.7526 MB / 0.8105 GB, free: 10.54 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.122e-05/0.6212, allocations: 45.28 kB / 0.8106 GB, free: 10.49 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=60): time 2.705e-06/0.6212, allocations: 6.438 kB / 0.8106 GB, free: 10.49 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=60): time 0.001681/0.6229, allocations: 0.9833 MB / 0.8115 GB, free: 9.988 MB / 0.5762 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.368e-05/0.6229, allocations: 57.38 kB / 0.8116 GB, free: 9.926 MB / 0.5762 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002144/0.625, allocations: 2.34 MB / 0.8139 GB, free: 7.629 MB / 0.5762 GB
Notification: Performance of collectPreVariables (initialization): time 8.655e-05/0.6251, allocations: 45.7 kB / 0.8139 GB, free: 7.578 MB / 0.5762 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006206/0.6258, allocations: 1.151 MB / 0.8151 GB, free: 6.422 MB / 0.5762 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001574/0.6259, allocations: 227.3 kB / 0.8153 GB, free: 6.203 MB / 0.5762 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002708/0.6262, allocations: 254.6 kB / 0.8155 GB, free: 5.949 MB / 0.5762 GB
Notification: Performance of setup shared object (initialization): time 5.971e-05/0.6263, allocations: 341.9 kB / 0.8158 GB, free: 5.609 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005013/0.6268, allocations: 361.9 kB / 0.8162 GB, free: 5.258 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006665/0.6274, allocations: 0.7478 MB / 0.8169 GB, free: 4.352 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001052/0.6285, allocations: 0.9809 MB / 0.8179 GB, free: 3.262 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.172e-06/0.6285, allocations: 4 kB / 0.8179 GB, free: 3.258 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=141) (initialization): time 0.001781/0.6303, allocations: 1.299 MB / 0.8191 GB, free: 1.969 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 1.996e-05/0.6303, allocations: 8 kB / 0.8191 GB, free: 1.961 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.031e-05/0.6304, allocations: 8 kB / 0.8192 GB, free: 1.953 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.433e-05/0.6304, allocations: 16 kB / 0.8192 GB, free: 1.938 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008475/0.6312, allocations: 247.6 kB / 0.8194 GB, free: 1.695 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.874e-05/0.6313, allocations: 20.42 kB / 0.8194 GB, free: 1.676 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001297/0.6326, allocations: 166.4 kB / 0.8196 GB, free: 1.512 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.013e-05/0.6326, allocations: 55.92 kB / 0.8196 GB, free: 1.457 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001026/0.6337, allocations: 0.7563 MB / 0.8204 GB, free: 0.6992 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0007638/0.6345, allocations: 0.7388 MB / 0.8211 GB, free: 15.8 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001329/0.6358, allocations: 0.9508 MB / 0.822 GB, free: 14.74 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.152e-06/0.6358, allocations: 8 kB / 0.822 GB, free: 14.73 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=141) (initialization_lambda0): time 0.002014/0.6378, allocations: 1.254 MB / 0.8233 GB, free: 13.47 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 1.58e-05/0.6379, allocations: 11.94 kB / 0.8233 GB, free: 13.46 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.598e-06/0.6379, allocations: 16.78 kB / 0.8233 GB, free: 13.45 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 6.499e-05/0.6379, allocations: 12 kB / 0.8233 GB, free: 13.43 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000837/0.6388, allocations: 255.6 kB / 0.8235 GB, free: 13.18 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.994e-05/0.6388, allocations: 23.92 kB / 0.8236 GB, free: 13.16 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001355/0.6402, allocations: 115.2 kB / 0.8237 GB, free: 13.05 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.593e-05/0.6403, allocations: 51.98 kB / 0.8237 GB, free: 13 MB / 0.5919 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 37
 * 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 (141):
 * Single equations (assignments): 141
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0002557/0.6405, allocations: 255.8 kB / 0.824 GB, free: 12.74 MB / 0.5919 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000315/0.6408, allocations: 233.3 kB / 0.8242 GB, free: 12.51 MB / 0.5919 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001531/0.6424, allocations: 0.8857 MB / 0.8251 GB, free: 11.61 MB / 0.5919 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.268e-05/0.6424, allocations: 11.98 kB / 0.8251 GB, free: 11.6 MB / 0.5919 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.359e-06/0.6424, allocations: 4 kB / 0.8251 GB, free: 11.6 MB / 0.5919 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0009413/0.6434, allocations: 0.6814 MB / 0.8257 GB, free: 10.89 MB / 0.5919 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003561/0.6469, allocations: 2.58 MB / 0.8283 GB, free: 8.242 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.798e-06/0.6469, allocations: 4.094 kB / 0.8283 GB, free: 8.238 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004878/0.6474, allocations: 127.8 kB / 0.8284 GB, free: 8.113 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (simulation): time 6.522e-06/0.6475, allocations: 4 kB / 0.8284 GB, free: 8.109 MB / 0.5919 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.708e-05/0.6475, allocations: 16 kB / 0.8284 GB, free: 8.094 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.821e-06/0.6475, allocations: 4 kB / 0.8284 GB, free: 8.09 MB / 0.5919 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.813e-06/0.6475, allocations: 0 / 0.8284 GB, free: 8.09 MB / 0.5919 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001801/0.6493, allocations: 1.317 MB / 0.8297 GB, free: 6.742 MB / 0.5919 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005635/0.6499, allocations: 417.9 kB / 0.8301 GB, free: 6.312 MB / 0.5919 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002342/0.6501, allocations: 12 kB / 0.8301 GB, free: 6.301 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008942/0.651, allocations: 51.94 kB / 0.8302 GB, free: 6.25 MB / 0.5919 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.933e-05/0.6511, allocations: 40.5 kB / 0.8302 GB, free: 6.211 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.338e-05/0.6512, allocations: 31.92 kB / 0.8302 GB, free: 6.18 MB / 0.5919 GB
Notification: Performance of sorting global known variables: time 0.001913/0.6531, allocations: 1.569 MB / 0.8318 GB, free: 4.605 MB / 0.5919 GB
Notification: Performance of sort global known variables: time 1.2e-07/0.6531, allocations: 0 / 0.8318 GB, free: 4.605 MB / 0.5919 GB
Notification: Performance of remove unused functions: time 0.002325/0.6555, allocations: 1.107 MB / 0.8328 GB, free: 3.496 MB / 0.5919 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 3 (valLin.vol.dynBal.U,valEquPerLin.vol.dynBal.U,valTab.vol.dynBal.U)
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (64):
 * Single equations (assignments): 61
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 3
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001441/0.6569, allocations: 0.7505 MB / 0.8336 GB, free: 2.918 MB / 0.5919 GB
Notification: Performance of simCode: created initialization part: time 0.002139/0.6591, allocations: 1.365 MB / 0.8349 GB, free: 1.555 MB / 0.5919 GB
Notification: Performance of simCode: created event and clocks part: time 2.876e-06/0.6591, allocations: 0 / 0.8349 GB, free: 1.555 MB / 0.5919 GB
Notification: Performance of simCode: created simulation system equations: time 0.0004839/0.6596, allocations: 328.4 kB / 0.8352 GB, free: 1.234 MB / 0.5919 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005071/0.6646, allocations: 1.388 MB / 0.8366 GB, free: 15.89 MB / 0.6075 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004924/0.6696, allocations: 3.662 MB / 0.8401 GB, free: 12.21 MB / 0.6075 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001074/0.6707, allocations: 1.594 MB / 0.8417 GB, free: 10.58 MB / 0.6075 GB
Notification: Performance of simCode: alias equations: time 0.001512/0.6722, allocations: 0.4909 MB / 0.8422 GB, free: 10.09 MB / 0.6075 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003355/0.6725, allocations: 179.4 kB / 0.8424 GB, free: 9.91 MB / 0.6075 GB
Notification: Performance of SimCode: time 7.21e-07/0.6725, allocations: 0 / 0.8424 GB, free: 9.91 MB / 0.6075 GB
Notification: Performance of Templates: time 0.06504/0.7376, allocations: 44.78 MB / 0.8861 GB, free: 13.74 MB / 0.6544 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves.sim & ./IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves.pipe 2>&1)