Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.4.0/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package BuildSysPro with version 3.4.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.4.0/package.mo)
Running command: translateModel(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume,tolerance=1e-09,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume")
translateModel(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume,tolerance=1e-09,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume")
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.4.0/UsersGuide/package.order:0:0-0:0:readonly] Warning: The package.order file does not list all .mo files and directories (containing package.mo) present in its directory.
Missing names are:
        License
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.4.0/package.mo): time 0.6323/0.6323, allocations: 117.9 MB / 133.9 MB, free: 4.508 MB / 106.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001125/0.001125, allocations: 173.8 kB / 161.7 MB, free: 2.75 MB / 122.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.642/1.642, allocations: 205.4 MB / 394.8 MB, free: 21.1 MB / 298.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0008129/0.000813, allocations: 107 kB / 470.1 MB, free: 12.35 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003726/0.0003727, allocations: 16 kB / 0.5423 GB, free: 7.078 MB / 442.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3564/0.3568, allocations: 74.54 MB / 0.6151 GB, free: 54.14 MB / 442.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 4.827/5.184, allocations: 2.162 GB / 2.777 GB, free: 220.4 MB / 0.6355 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003622/5.184, allocations: 93.36 kB / 2.778 GB, free: 220.4 MB / 0.6355 GB
Notification: Performance of FrontEnd - DAE generated: time 4.989/10.17, allocations: 1.329 GB / 4.106 GB, free: 60.99 MB / 0.6667 GB
Notification: Performance of FrontEnd: time 2.525e-06/10.17, allocations: 0 / 4.106 GB, free: 60.99 MB / 0.6667 GB
Notification: Performance of Transformations before backend: time 0.0002953/10.17, allocations: 60.34 kB / 4.106 GB, free: 60.98 MB / 0.6667 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 369
 * Number of variables: 369
Notification: Performance of Generate backend data structure: time 0.00849/10.18, allocations: 2.474 MB / 4.109 GB, free: 59.87 MB / 0.6667 GB
Notification: Performance of prepare preOptimizeDAE: time 4.496e-05/10.18, allocations: 10.91 kB / 4.109 GB, free: 59.87 MB / 0.6667 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003908/10.19, allocations: 0.5005 MB / 4.109 GB, free: 59.76 MB / 0.6667 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004952/10.19, allocations: 1.55 MB / 4.111 GB, free: 59.27 MB / 0.6667 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002485/10.19, allocations: 178.6 kB / 4.111 GB, free: 59.21 MB / 0.6667 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006546/10.19, allocations: 154.7 kB / 4.111 GB, free: 59.21 MB / 0.6667 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00625/10.2, allocations: 2.012 MB / 4.113 GB, free: 59.02 MB / 0.6667 GB
Notification: Performance of preOpt findStateOrder (simulation): time 6.693e-05/10.2, allocations: 13.42 kB / 4.113 GB, free: 59.02 MB / 0.6667 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0003092/10.2, allocations: 62.88 kB / 4.113 GB, free: 59.02 MB / 0.6667 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.606e-05/10.2, allocations: 61.84 kB / 4.113 GB, free: 59.01 MB / 0.6667 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004702/10.2, allocations: 1.679 MB / 4.115 GB, free: 59 MB / 0.6667 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.01285/10.22, allocations: 7.66 MB / 4.122 GB, free: 54.8 MB / 0.6667 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00311/10.22, allocations: 1.279 MB / 4.123 GB, free: 54.76 MB / 0.6667 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0008483/10.22, allocations: 0.5491 MB / 4.124 GB, free: 54.75 MB / 0.6667 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005174/10.22, allocations: 317.2 kB / 4.124 GB, free: 54.46 MB / 0.6667 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.329e-05/10.22, allocations: 49.06 kB / 4.124 GB, free: 54.42 MB / 0.6667 GB
Notification: Performance of pre-optimization done (n=104): time 4.128e-06/10.22, allocations: 2.219 kB / 4.124 GB, free: 54.42 MB / 0.6667 GB
Notification: Performance of matching and sorting (n=110): time 0.01207/10.23, allocations: 4.029 MB / 4.128 GB, free: 53.75 MB / 0.6667 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.28e-05/10.23, allocations: 63.97 kB / 4.128 GB, free: 53.68 MB / 0.6667 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002302/10.24, allocations: 1.232 MB / 4.13 GB, free: 53.52 MB / 0.6667 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002015/10.24, allocations: 53.05 kB / 4.13 GB, free: 53.49 MB / 0.6667 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006491/10.24, allocations: 0.8015 MB / 4.13 GB, free: 53.18 MB / 0.6667 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003476/10.24, allocations: 404.2 kB / 4.131 GB, free: 52.93 MB / 0.6667 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 9.638e-05/10.24, allocations: 22.84 kB / 4.131 GB, free: 52.93 MB / 0.6667 GB
Notification: Performance of setup shared object (initialization): time 0.0001079/10.24, allocations: 355.6 kB / 4.131 GB, free: 52.62 MB / 0.6667 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001179/10.24, allocations: 0.5423 MB / 4.132 GB, free: 52.62 MB / 0.6667 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001405/10.24, allocations: 0.9207 MB / 4.133 GB, free: 52.2 MB / 0.6667 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002663/10.24, allocations: 1.429 MB / 4.134 GB, free: 51.89 MB / 0.6667 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.132e-05/10.24, allocations: 3.875 kB / 4.134 GB, free: 51.89 MB / 0.6667 GB
Notification: Performance of matching and sorting (n=155) (initialization): time 0.00352/10.25, allocations: 1.619 MB / 4.135 GB, free: 51.71 MB / 0.6667 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002593/10.25, allocations: 320.9 kB / 4.136 GB, free: 51.35 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.133e-05/10.25, allocations: 5.75 kB / 4.136 GB, free: 51.35 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.859e-05/10.25, allocations: 17.73 kB / 4.136 GB, free: 51.35 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00154/10.25, allocations: 338.9 kB / 4.136 GB, free: 51.33 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.216e-05/10.25, allocations: 20.14 kB / 4.136 GB, free: 51.32 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002745/10.25, allocations: 217.4 kB / 4.136 GB, free: 51.31 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001851/10.25, allocations: 57.05 kB / 4.136 GB, free: 51.31 MB / 0.6667 GB
Notification: Performance of prepare postOptimizeDAE: time 1.569e-05/10.25, allocations: 5.594 kB / 4.136 GB, free: 51.31 MB / 0.6667 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002233/10.25, allocations: 1.234 MB / 4.138 GB, free: 51.24 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.713e-05/10.25, allocations: 10.16 kB / 4.138 GB, free: 51.24 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.994e-05/10.25, allocations: 13.72 kB / 4.138 GB, free: 51.24 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001111/10.25, allocations: 285.7 kB / 4.138 GB, free: 51.22 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.609e-05/10.25, allocations: 17 kB / 4.138 GB, free: 51.22 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002127/10.26, allocations: 176.5 kB / 4.138 GB, free: 51.2 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001225/10.26, allocations: 51.92 kB / 4.138 GB, free: 51.2 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 34
 * Number of states: 0 ()
 * Number of discrete variables: 4 (vol.regularFlow[1],vol.regularFlow[2],vol.inFlow[2],vol.inFlow[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (155):
 * Single equations (assignments): 155
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.001221/10.26, allocations: 0.5154 MB / 4.139 GB, free: 50.99 MB / 0.6667 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005037/10.26, allocations: 172.2 kB / 4.139 GB, free: 50.9 MB / 0.6667 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003226/10.26, allocations: 1.441 MB / 4.14 GB, free: 50.81 MB / 0.6667 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.083e-05/10.26, allocations: 11.69 kB / 4.14 GB, free: 50.81 MB / 0.6667 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.275e-06/10.26, allocations: 1.344 kB / 4.14 GB, free: 50.81 MB / 0.6667 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002373/10.26, allocations: 1.335 MB / 4.142 GB, free: 50.54 MB / 0.6667 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006782/10.27, allocations: 3.118 MB / 4.145 GB, free: 50.13 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.035e-06/10.27, allocations: 0 / 4.145 GB, free: 50.13 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001542/10.27, allocations: 320.7 kB / 4.145 GB, free: 50.12 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.112e-05/10.27, allocations: 7.156 kB / 4.145 GB, free: 50.12 MB / 0.6667 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001088/10.27, allocations: 36.7 kB / 4.145 GB, free: 50.12 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.328e-05/10.27, allocations: 11.78 kB / 4.145 GB, free: 50.11 MB / 0.6667 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.116e-06/10.27, allocations: 0 / 4.145 GB, free: 50.11 MB / 0.6667 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00426/10.28, allocations: 2.212 MB / 4.147 GB, free: 49.8 MB / 0.6667 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001171/10.28, allocations: 353.1 kB / 4.147 GB, free: 49.62 MB / 0.6667 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005018/10.28, allocations: 26.72 kB / 4.147 GB, free: 49.62 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002103/10.28, allocations: 200.1 kB / 4.148 GB, free: 49.61 MB / 0.6667 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001807/10.28, allocations: 66.7 kB / 4.148 GB, free: 49.61 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001552/10.28, allocations: 47.69 kB / 4.148 GB, free: 49.61 MB / 0.6667 GB
Notification: Performance of sorting global known variables: time 0.001673/10.28, allocations: 0.8226 MB / 4.149 GB, free: 49.5 MB / 0.6667 GB
Notification: Performance of sort global known variables: time 4.41e-07/10.28, allocations: 2.062 kB / 4.149 GB, free: 49.5 MB / 0.6667 GB
Notification: Performance of remove unused functions: time 0.005213/10.29, allocations: 1.092 MB / 4.15 GB, free: 49.49 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 12 (vol1.dynBal.U,vol1.dynBal.m,vol1.dynBal.mXi[1],vol.medium.Xi[1],vol.medium.T,vol.m,entFloRat.h_out,entFloRat1.h_out,vol2.dynBal.U,vol2.dynBal.m,vol2.dynBal.mXi[1],entFloRat2.h_out)
 * 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 (110):
 * Single equations (assignments): 110
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.005227/10.29, allocations: 3.095 MB / 4.153 GB, free: 48.18 MB / 0.6667 GB
Notification: Performance of simCode: created initialization part: time 0.00478/10.3, allocations: 1.983 MB / 4.155 GB, free: 48.09 MB / 0.6667 GB
Notification: Performance of simCode: created event and clocks part: time 9.237e-06/10.3, allocations: 0 / 4.155 GB, free: 48.09 MB / 0.6667 GB
Notification: Performance of simCode: created simulation system equations: time 0.001382/10.3, allocations: 0.6515 MB / 4.155 GB, free: 48.07 MB / 0.6667 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006137/10.31, allocations: 0.968 MB / 4.156 GB, free: 48 MB / 0.6667 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008071/10.31, allocations: 4.597 MB / 4.161 GB, free: 45.61 MB / 0.6667 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001422/10.32, allocations: 1.464 MB / 4.162 GB, free: 44.8 MB / 0.6667 GB
Notification: Performance of simCode: alias equations: time 0.003077/10.32, allocations: 0.5641 MB / 4.163 GB, free: 44.72 MB / 0.6667 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006828/10.32, allocations: 145.7 kB / 4.163 GB, free: 44.71 MB / 0.6667 GB
Notification: Performance of SimCode: time 1.172e-06/10.32, allocations: 0 / 4.163 GB, free: 44.71 MB / 0.6667 GB
Notification: Performance of Templates: time 0.0954/10.41, allocations: 65.11 MB / 4.226 GB, free: 8.758 MB / 0.6823 GB
make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.makefile
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.sim & ./BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe 2>&1)