Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo", uses=false)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/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)
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 BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo)
Running command: translateModel(BuildingSystems.Fluid.Examples.Performance.Example4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4")
translateModel(BuildingSystems.Fluid.Examples.Performance.Example4,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 0.8829/0.8829, allocations: 143.4 MB / 158.3 MB, free: 5.785 MB / 122.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001158/0.001158, allocations: 177.1 kB / 191.5 MB, free: 5.75 MB / 154.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.651/1.651, allocations: 223.2 MB / 447.7 MB, free: 6.555 MB / 330.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001116/0.001116, allocations: 96.25 kB / 0.5188 GB, free: 2.902 MB / 410.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.001732/0.001732, allocations: 258.2 kB / 0.6005 GB, free: 48.96 MB / 410.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004642/0.0004642, allocations: 12 kB / 0.6929 GB, free: 2.293 MB / 458.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4748/0.4753, allocations: 82.79 MB / 0.7737 GB, free: 26.18 MB / 458.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 4.519/4.995, allocations: 1.912 GB / 2.685 GB, free: 110 MB / 0.698 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002477/4.995, allocations: 95.83 kB / 2.685 GB, free: 109.9 MB / 0.698 GB
Notification: Performance of FrontEnd - DAE generated: time 5.679/10.67, allocations: 1.472 GB / 4.157 GB, free: 87.84 MB / 0.7448 GB
Notification: Performance of FrontEnd: time 2.134e-06/10.67, allocations: 0 / 4.157 GB, free: 87.84 MB / 0.7448 GB
Notification: Performance of Transformations before backend: time 0.0001238/10.67, allocations: 43.62 kB / 4.157 GB, free: 87.84 MB / 0.7448 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 251
 * Number of variables: 251
Notification: Performance of Generate backend data structure: time 0.006311/10.68, allocations: 2.137 MB / 4.159 GB, free: 87.32 MB / 0.7448 GB
Notification: Performance of prepare preOptimizeDAE: time 5.247e-05/10.68, allocations: 12.25 kB / 4.159 GB, free: 87.32 MB / 0.7448 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003407/10.68, allocations: 0.5141 MB / 4.16 GB, free: 87.23 MB / 0.7448 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003464/10.69, allocations: 1.226 MB / 4.161 GB, free: 86.93 MB / 0.7448 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008725/10.69, allocations: 282.2 kB / 4.161 GB, free: 86.93 MB / 0.7448 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002548/10.69, allocations: 99.56 kB / 4.161 GB, free: 86.93 MB / 0.7448 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002741/10.69, allocations: 1.326 MB / 4.163 GB, free: 86.63 MB / 0.7448 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.341e-05/10.69, allocations: 3.438 kB / 4.163 GB, free: 86.63 MB / 0.7448 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001082/10.69, allocations: 40.91 kB / 4.163 GB, free: 86.63 MB / 0.7448 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.539e-05/10.69, allocations: 51.17 kB / 4.163 GB, free: 86.63 MB / 0.7448 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002435/10.69, allocations: 1.075 MB / 4.164 GB, free: 86.62 MB / 0.7448 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.008645/10.7, allocations: 6.648 MB / 4.17 GB, free: 82.53 MB / 0.7448 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002089/10.7, allocations: 0.631 MB / 4.171 GB, free: 82.51 MB / 0.7448 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004001/10.71, allocations: 285.1 kB / 4.171 GB, free: 82.23 MB / 0.7448 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.961e-05/10.71, allocations: 38.19 kB / 4.171 GB, free: 82.19 MB / 0.7448 GB
Notification: Performance of pre-optimization done (n=33): time 2.735e-06/10.71, allocations: 0 / 4.171 GB, free: 82.19 MB / 0.7448 GB
Notification: Performance of matching and sorting (n=33): time 0.003174/10.71, allocations: 0.9007 MB / 4.172 GB, free: 82.08 MB / 0.7448 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.809e-05/10.71, allocations: 58.22 kB / 4.172 GB, free: 82.02 MB / 0.7448 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002248/10.71, allocations: 1.187 MB / 4.173 GB, free: 81.86 MB / 0.7448 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001383/10.71, allocations: 43.25 kB / 4.173 GB, free: 81.83 MB / 0.7448 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005614/10.71, allocations: 0.6739 MB / 4.174 GB, free: 81.62 MB / 0.7448 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001227/10.71, allocations: 125.2 kB / 4.174 GB, free: 81.57 MB / 0.7448 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.673e-05/10.71, allocations: 9.812 kB / 4.174 GB, free: 81.57 MB / 0.7448 GB
Notification: Performance of setup shared object (initialization): time 0.0001068/10.71, allocations: 336 kB / 4.174 GB, free: 81.26 MB / 0.7448 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008122/10.71, allocations: 329.4 kB / 4.175 GB, free: 81.26 MB / 0.7448 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009741/10.71, allocations: 0.6715 MB / 4.175 GB, free: 80.83 MB / 0.7448 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008875/10.71, allocations: 409.6 kB / 4.176 GB, free: 80.82 MB / 0.7448 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.931e-06/10.71, allocations: 3.812 kB / 4.176 GB, free: 80.82 MB / 0.7448 GB
Notification: Performance of matching and sorting (n=81) (initialization): time 0.002508/10.72, allocations: 1.053 MB / 4.177 GB, free: 80.71 MB / 0.7448 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0009058/10.72, allocations: 3.81 MB / 4.181 GB, free: 76.82 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.681e-05/10.72, allocations: 7.781 kB / 4.181 GB, free: 76.82 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.173e-05/10.72, allocations: 16.56 kB / 4.181 GB, free: 76.82 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008966/10.72, allocations: 212.4 kB / 4.181 GB, free: 76.82 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.303e-05/10.72, allocations: 21.44 kB / 4.181 GB, free: 76.82 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001842/10.72, allocations: 241.6 kB / 4.181 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.615e-05/10.72, allocations: 43.33 kB / 4.181 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of prepare postOptimizeDAE: time 1.257e-05/10.72, allocations: 4.844 kB / 4.181 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001897/10.72, allocations: 0.895 MB / 4.182 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.286e-05/10.72, allocations: 11.22 kB / 4.182 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.537e-05/10.72, allocations: 14.56 kB / 4.182 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007682/10.72, allocations: 207.5 kB / 4.182 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.59e-05/10.72, allocations: 18.08 kB / 4.182 GB, free: 76.79 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001586/10.73, allocations: 203.5 kB / 4.182 GB, free: 76.76 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.19e-05/10.73, allocations: 45.22 kB / 4.182 GB, free: 76.76 MB / 0.7448 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 43
 * 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 (81):
 * Single equations (assignments): 81
 * 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.0009288/10.73, allocations: 417.3 kB / 4.183 GB, free: 76.57 MB / 0.7448 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002689/10.73, allocations: 134.9 kB / 4.183 GB, free: 76.5 MB / 0.7448 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001614/10.73, allocations: 0.6793 MB / 4.184 GB, free: 76.44 MB / 0.7448 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.554e-06/10.73, allocations: 8.344 kB / 4.184 GB, free: 76.44 MB / 0.7448 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.081e-06/10.73, allocations: 0 / 4.184 GB, free: 76.44 MB / 0.7448 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.269e-06/10.73, allocations: 3 kB / 4.184 GB, free: 76.44 MB / 0.7448 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003649/10.73, allocations: 1.931 MB / 4.186 GB, free: 75.99 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.052e-06/10.73, allocations: 4.281 kB / 4.186 GB, free: 75.99 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0005069/10.73, allocations: 105.2 kB / 4.186 GB, free: 75.99 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.089e-05/10.73, allocations: 9.031 kB / 4.186 GB, free: 75.99 MB / 0.7448 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.68e-05/10.73, allocations: 11.34 kB / 4.186 GB, free: 75.99 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.466e-06/10.73, allocations: 6.625 kB / 4.186 GB, free: 75.99 MB / 0.7448 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.875e-06/10.73, allocations: 12.31 kB / 4.186 GB, free: 75.99 MB / 0.7448 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001631/10.73, allocations: 1.05 MB / 4.187 GB, free: 75.36 MB / 0.7448 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006516/10.73, allocations: 285.9 kB / 4.187 GB, free: 75.2 MB / 0.7448 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002101/10.74, allocations: 19.06 kB / 4.187 GB, free: 75.2 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001009/10.74, allocations: 108 kB / 4.187 GB, free: 75.19 MB / 0.7448 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.3e-05/10.74, allocations: 31.92 kB / 4.187 GB, free: 75.19 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.999e-05/10.74, allocations: 27.95 kB / 4.187 GB, free: 75.19 MB / 0.7448 GB
Notification: Performance of sorting global known variables: time 0.00141/10.74, allocations: 0.9292 MB / 4.188 GB, free: 75.08 MB / 0.7448 GB
Notification: Performance of sort global known variables: time 2.1e-07/10.74, allocations: 0 / 4.188 GB, free: 75.08 MB / 0.7448 GB
Notification: Performance of remove unused functions: time 0.003399/10.74, allocations: 0.8727 MB / 4.189 GB, free: 75.05 MB / 0.7448 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 16
 * 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 simulation (32):
 * Single equations (assignments): 32
 * 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.005499/10.75, allocations: 3.153 MB / 4.192 GB, free: 73.75 MB / 0.7448 GB
Notification: Performance of simCode: created initialization part: time 0.00309/10.75, allocations: 1.161 MB / 4.193 GB, free: 73.73 MB / 0.7448 GB
Notification: Performance of simCode: created event and clocks part: time 7.675e-06/10.75, allocations: 0 / 4.193 GB, free: 73.73 MB / 0.7448 GB
Notification: Performance of simCode: created simulation system equations: time 0.0006837/10.75, allocations: 277.8 kB / 4.193 GB, free: 73.73 MB / 0.7448 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00334/10.75, allocations: 0.6237 MB / 4.194 GB, free: 73.71 MB / 0.7448 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005453/10.76, allocations: 2.658 MB / 4.197 GB, free: 72.48 MB / 0.7448 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006644/10.76, allocations: 1.206 MB / 4.198 GB, free: 71.77 MB / 0.7448 GB
Notification: Performance of simCode: alias equations: time 0.001878/10.76, allocations: 355.8 kB / 4.198 GB, free: 71.75 MB / 0.7448 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002453/10.76, allocations: 87.19 kB / 4.198 GB, free: 71.74 MB / 0.7448 GB
Notification: Performance of SimCode: time 1.313e-06/10.76, allocations: 0 / 4.198 GB, free: 71.74 MB / 0.7448 GB
Notification: Performance of Templates: time 0.07829/10.84, allocations: 54.96 MB / 4.252 GB, free: 69.46 MB / 0.7448 GB
make -j1 -f BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4.makefile
(rm -f BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4.pipe ; mkfifo BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4.pipe >> ../files/BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4.sim & ./BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.Fluid.Examples.Performance.Example4.pipe 2>&1)