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.001487/0.001487, allocations: 96.83 kB / 16.26 MB, free: 5.934 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.001675/0.001675, allocations: 189.6 kB / 17.2 MB, free: 5.574 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.374/1.374, allocations: 222.9 MB / 240.9 MB, free: 15.22 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.8727/0.8727, allocations: 122.9 MB / 413.9 MB, free: 15.84 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.002109/0.002109, allocations: 63.91 kB / 0.4911 GB, free: 7.379 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4519/0.454, allocations: 77.93 MB / 0.5672 GB, free: 32.7 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Actuators.Valves.Examples.ThreeWayValves): time 0.109/0.563, allocations: 112.6 MB / 0.6772 GB, free: 9.828 MB / 0.5137 GB
Notification: Performance of NFInst.instExpressions: time 0.04418/0.6072, allocations: 20.26 MB / 0.697 GB, free: 5.523 MB / 0.5294 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00559/0.6129, allocations: 111.3 kB / 0.6971 GB, free: 5.414 MB / 0.5294 GB
Notification: Performance of NFTyping.typeComponents: time 0.004409/0.6174, allocations: 1.281 MB / 0.6983 GB, free: 4.125 MB / 0.5294 GB
Notification: Performance of NFTyping.typeBindings: time 0.0108/0.6282, allocations: 3.682 MB / 0.7019 GB, free: 440 kB / 0.5294 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00824/0.6364, allocations: 3.075 MB / 0.7049 GB, free: 13.41 MB / 0.545 GB
Notification: Performance of NFFlatten.flatten: time 0.009877/0.6463, allocations: 7.192 MB / 0.712 GB, free: 6.191 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004346/0.6507, allocations: 2.576 MB / 0.7145 GB, free: 3.555 MB / 0.545 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007054/0.6578, allocations: 2.799 MB / 0.7172 GB, free: 0.7539 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004191/0.662, allocations: 2.124 MB / 0.7193 GB, free: 14.62 MB / 0.5606 GB
Notification: Performance of NFPackage.collectConstants: time 0.00119/0.6632, allocations: 256 kB / 0.7195 GB, free: 14.37 MB / 0.5606 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005332/0.6686, allocations: 1.65 MB / 0.7212 GB, free: 12.72 MB / 0.5606 GB
Notification: Performance of NFScalarize.scalarize: time 0.001397/0.67, allocations: 0.6889 MB / 0.7218 GB, free: 12.03 MB / 0.5606 GB
Notification: Performance of NFVerifyModel.verify: time 0.003355/0.6734, allocations: 1.512 MB / 0.7233 GB, free: 10.51 MB / 0.5606 GB
Notification: Performance of NFConvertDAE.convert: time 0.007501/0.6809, allocations: 4.338 MB / 0.7275 GB, free: 6.156 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 5.6e-06/0.6809, allocations: 0 / 0.7275 GB, free: 6.156 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 1.804e-06/0.6809, allocations: 0 / 0.7275 GB, free: 6.156 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 0.0001327/0.6811, allocations: 4 kB / 0.7275 GB, free: 6.152 MB / 0.5606 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.006413/0.6875, allocations: 3.226 MB / 0.7307 GB, free: 2.859 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 4.72e-05/0.6876, allocations: 8.625 kB / 0.7307 GB, free: 2.852 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0008791/0.6884, allocations: 332.5 kB / 0.731 GB, free: 2.523 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003637/0.6921, allocations: 2.093 MB / 0.7331 GB, free: 368 kB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.241e-05/0.6922, allocations: 127 kB / 0.7332 GB, free: 240 kB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000221/0.6924, allocations: 175.9 kB / 0.7333 GB, free: 64 kB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002907/0.6954, allocations: 1.61 MB / 0.7349 GB, free: 14.39 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.879e-05/0.6954, allocations: 7.984 kB / 0.7349 GB, free: 14.38 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001296/0.6955, allocations: 67.88 kB / 0.735 GB, free: 14.31 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.979e-05/0.6956, allocations: 43.94 kB / 0.735 GB, free: 14.27 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001992/0.6976, allocations: 1.143 MB / 0.7362 GB, free: 13.12 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.01169/0.7093, allocations: 7.975 MB / 0.7439 GB, free: 4.641 MB / 0.5762 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0008638/0.7102, allocations: 477.9 kB / 0.7444 GB, free: 4.164 MB / 0.5762 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005028/0.7107, allocations: 319 kB / 0.7447 GB, free: 3.852 MB / 0.5762 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007943/0.7115, allocations: 0.7602 MB / 0.7454 GB, free: 2.926 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.003e-05/0.7116, allocations: 39.12 kB / 0.7455 GB, free: 2.879 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=60): time 2.706e-06/0.7116, allocations: 4 kB / 0.7455 GB, free: 2.875 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=60): time 0.002277/0.7139, allocations: 0.9842 MB / 0.7464 GB, free: 1.887 MB / 0.5762 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.101e-05/0.7139, allocations: 55.97 kB / 0.7465 GB, free: 1.82 MB / 0.5762 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.2613/0.9753, allocations: 2.335 MB / 0.7488 GB, free: 164.2 MB / 0.5762 GB
Notification: Performance of collectPreVariables (initialization): time 0.00024/0.9756, allocations: 47.77 kB / 0.7488 GB, free: 164.1 MB / 0.5762 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00105/0.9766, allocations: 1.154 MB / 0.7499 GB, free: 163.7 MB / 0.5762 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002483/0.9769, allocations: 218.6 kB / 0.7502 GB, free: 163.6 MB / 0.5762 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003928/0.9773, allocations: 254.9 kB / 0.7504 GB, free: 163.5 MB / 0.5762 GB
Notification: Performance of setup shared object (initialization): time 8.444e-05/0.9774, allocations: 349.4 kB / 0.7507 GB, free: 163.2 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007512/0.9781, allocations: 359.5 kB / 0.7511 GB, free: 163.1 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009621/0.9791, allocations: 0.7429 MB / 0.7518 GB, free: 162.5 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001419/0.9805, allocations: 0.9818 MB / 0.7528 GB, free: 161.9 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.937e-06/0.9805, allocations: 6.938 kB / 0.7528 GB, free: 161.9 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=141) (initialization): time 0.002737/0.9833, allocations: 1.294 MB / 0.754 GB, free: 161.3 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 2.868e-05/0.9833, allocations: 9.672 kB / 0.754 GB, free: 161.3 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.052e-05/0.9834, allocations: 12.81 kB / 0.7541 GB, free: 161.3 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.562e-05/0.9834, allocations: 14 kB / 0.7541 GB, free: 161.3 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001047/0.9844, allocations: 254.9 kB / 0.7543 GB, free: 161.3 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.254e-05/0.9845, allocations: 15.5 kB / 0.7543 GB, free: 161.3 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001554/0.9861, allocations: 168 kB / 0.7545 GB, free: 161.2 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001144/0.9862, allocations: 51.69 kB / 0.7545 GB, free: 161.2 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001707/0.9879, allocations: 0.7656 MB / 0.7553 GB, free: 160.8 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0009814/0.9889, allocations: 0.7376 MB / 0.756 GB, free: 160.2 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001379/0.9903, allocations: 0.9503 MB / 0.7569 GB, free: 159.6 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.003e-06/0.9903, allocations: 2.781 kB / 0.7569 GB, free: 159.6 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=141) (initialization_lambda0): time 0.002664/0.993, allocations: 1.258 MB / 0.7582 GB, free: 159.1 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 2.072e-05/0.993, allocations: 8.781 kB / 0.7582 GB, free: 159.1 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.435e-05/0.993, allocations: 8.531 kB / 0.7582 GB, free: 159.1 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.095e-05/0.993, allocations: 14.78 kB / 0.7582 GB, free: 159.1 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009017/0.9939, allocations: 249.9 kB / 0.7584 GB, free: 159.1 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.511e-05/0.994, allocations: 21.14 kB / 0.7584 GB, free: 159.1 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001689/0.9957, allocations: 125.3 kB / 0.7586 GB, free: 159 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.151e-05/0.9958, allocations: 49.42 kB / 0.7586 GB, free: 159 MB / 0.5762 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.0003404/0.9961, allocations: 253.3 kB / 0.7589 GB, free: 158.8 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003618/0.9965, allocations: 235.8 kB / 0.7591 GB, free: 158.6 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001923/0.9984, allocations: 0.8889 MB / 0.76 GB, free: 158.3 MB / 0.5762 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.982e-05/0.9985, allocations: 7.344 kB / 0.76 GB, free: 158.3 MB / 0.5762 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.703e-06/0.9985, allocations: 0.9688 kB / 0.76 GB, free: 158.3 MB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00105/0.9995, allocations: 0.6863 MB / 0.7606 GB, free: 157.9 MB / 0.5762 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004253/1.004, allocations: 2.581 MB / 0.7631 GB, free: 156.7 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.324e-06/1.004, allocations: 2.078 kB / 0.7632 GB, free: 156.7 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000574/1.004, allocations: 128.5 kB / 0.7633 GB, free: 156.7 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (simulation): time 7.023e-06/1.004, allocations: 5.094 kB / 0.7633 GB, free: 156.7 MB / 0.5762 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.808e-05/1.004, allocations: 17.67 kB / 0.7633 GB, free: 156.7 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 6.582e-06/1.004, allocations: 3.359 kB / 0.7633 GB, free: 156.7 MB / 0.5762 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.136e-06/1.004, allocations: 1.938 kB / 0.7633 GB, free: 156.7 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001943/1.006, allocations: 1.322 MB / 0.7646 GB, free: 156 MB / 0.5762 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006403/1.007, allocations: 419.3 kB / 0.765 GB, free: 155.7 MB / 0.5762 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002515/1.007, allocations: 13.92 kB / 0.765 GB, free: 155.7 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009172/1.008, allocations: 47.45 kB / 0.765 GB, free: 155.7 MB / 0.5762 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001011/1.008, allocations: 40.47 kB / 0.7651 GB, free: 155.7 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.571e-05/1.008, allocations: 35.47 kB / 0.7651 GB, free: 155.7 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.002182/1.011, allocations: 1.573 MB / 0.7667 GB, free: 155.1 MB / 0.5762 GB
Notification: Performance of sort global known variables: time 2.41e-07/1.011, allocations: 0 / 0.7667 GB, free: 155.1 MB / 0.5762 GB
Notification: Performance of remove unused functions: time 0.003122/1.014, allocations: 1.105 MB / 0.7677 GB, free: 154.9 MB / 0.5762 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.001833/1.016, allocations: 0.7556 MB / 0.7685 GB, free: 154.8 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.002748/1.018, allocations: 1.448 MB / 0.7699 GB, free: 154.3 MB / 0.5762 GB
Notification: Performance of simCode: created event and clocks part: time 4.088e-06/1.018, allocations: 0 / 0.7699 GB, free: 154.3 MB / 0.5762 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005317/1.019, allocations: 325.3 kB / 0.7702 GB, free: 154.2 MB / 0.5762 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005633/1.025, allocations: 1.388 MB / 0.7716 GB, free: 153.9 MB / 0.5762 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004808/1.029, allocations: 3.729 MB / 0.7752 GB, free: 152 MB / 0.5762 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007514/1.03, allocations: 1.591 MB / 0.7768 GB, free: 151 MB / 0.5762 GB
Notification: Performance of simCode: alias equations: time 0.002084/1.032, allocations: 0.4928 MB / 0.7772 GB, free: 150.7 MB / 0.5762 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003766/1.033, allocations: 181.6 kB / 0.7774 GB, free: 150.7 MB / 0.5762 GB
Notification: Performance of SimCode: time 8.81e-07/1.033, allocations: 3.938 kB / 0.7774 GB, free: 150.7 MB / 0.5762 GB
Notification: Performance of Templates: time 0.06009/1.093, allocations: 46.87 MB / 0.8232 GB, free: 107.2 MB / 0.5762 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)