Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2.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/BuildSysPro 3.6.0/package.mo", uses=false)
Using package BuildSysPro with version 3.5.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/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(BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2")
translateModel(BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00184/0.00184, allocations: 108.7 kB / 16.41 MB, free: 6.504 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: 185.7 kB / 17.35 MB, free: 5.762 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.359/1.359, allocations: 222.9 MB / 241.1 MB, free: 15.16 MB / 206.1 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/package.mo): time 0.8653/0.8653, allocations: 143 MB / 434.3 MB, free: 12 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.00233/0.00233, allocations: 72.19 kB / 0.5962 GB, free: 12.3 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1775/0.1798, allocations: 82.03 MB / 0.6763 GB, free: 10.35 MB / 0.5137 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pump_dp.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2): time 0.04154/0.2214, allocations: 30.12 MB / 0.7057 GB, free: 12.12 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.01992/0.2414, allocations: 11.79 MB / 0.7172 GB, free: 304 kB / 0.545 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001885/0.2433, allocations: 47.75 kB / 0.7173 GB, free: 256 kB / 0.545 GB
Notification: Performance of NFTyping.typeComponents: time 0.004421/0.2477, allocations: 1.508 MB / 0.7187 GB, free: 14.74 MB / 0.5606 GB
Notification: Performance of NFTyping.typeBindings: time 0.004385/0.2521, allocations: 1.672 MB / 0.7204 GB, free: 13.06 MB / 0.5606 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003615/0.2558, allocations: 1.471 MB / 0.7218 GB, free: 11.59 MB / 0.5606 GB
Notification: Performance of NFFlatten.flatten: time 0.009156/0.2649, allocations: 6.771 MB / 0.7284 GB, free: 4.812 MB / 0.5606 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00229/0.2673, allocations: 1.396 MB / 0.7298 GB, free: 3.379 MB / 0.5606 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003429/0.2707, allocations: 1.528 MB / 0.7313 GB, free: 1.848 MB / 0.5606 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002004/0.2727, allocations: 1.121 MB / 0.7324 GB, free: 0.7227 MB / 0.5606 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004605/0.2732, allocations: 132 kB / 0.7325 GB, free: 0.5938 MB / 0.5606 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003022/0.2762, allocations: 1.314 MB / 0.7338 GB, free: 15.28 MB / 0.5762 GB
Notification: Performance of NFScalarize.scalarize: time 0.000764/0.277, allocations: 0.545 MB / 0.7343 GB, free: 14.73 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.001687/0.2787, allocations: 0.9755 MB / 0.7353 GB, free: 13.75 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.004864/0.2836, allocations: 3.197 MB / 0.7384 GB, free: 10.54 MB / 0.5762 GB
Notification: Performance of FrontEnd - DAE generated: time 4.438e-06/0.2836, allocations: 0 / 0.7384 GB, free: 10.54 MB / 0.5762 GB
Notification: Performance of FrontEnd: time 1.623e-06/0.2836, allocations: 0 / 0.7384 GB, free: 10.54 MB / 0.5762 GB
Notification: Performance of Transformations before backend: time 9.299e-05/0.2837, allocations: 0 / 0.7384 GB, free: 10.54 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: 192
 * Number of variables: 192
Notification: Performance of Generate backend data structure: time 0.005152/0.2889, allocations: 2.398 MB / 0.7407 GB, free: 8.074 MB / 0.5762 GB
Notification: Performance of prepare preOptimizeDAE: time 4.435e-05/0.2889, allocations: 8.031 kB / 0.7407 GB, free: 8.066 MB / 0.5762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001964/0.2909, allocations: 382.2 kB / 0.7411 GB, free: 7.691 MB / 0.5762 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004384/0.2953, allocations: 2.408 MB / 0.7435 GB, free: 5.234 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.707e-05/0.2954, allocations: 69.98 kB / 0.7435 GB, free: 5.168 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001702/0.2955, allocations: 84 kB / 0.7436 GB, free: 5.086 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001756/0.2973, allocations: 1.005 MB / 0.7446 GB, free: 4.02 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.034e-05/0.2973, allocations: 4 kB / 0.7446 GB, free: 4.016 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.853e-05/0.2974, allocations: 39.98 kB / 0.7446 GB, free: 3.977 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.089e-05/0.2975, allocations: 20 kB / 0.7446 GB, free: 3.957 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001573/0.299, allocations: 0.7493 MB / 0.7454 GB, free: 3.211 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.3436/0.6426, allocations: 5.256 MB / 0.7505 GB, free: 66.94 MB / 0.5762 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001433/0.6441, allocations: 0.5641 MB / 0.7511 GB, free: 66.91 MB / 0.5762 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007212/0.6448, allocations: 320.3 kB / 0.7514 GB, free: 66.91 MB / 0.5762 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002682/0.6475, allocations: 1.669 MB / 0.753 GB, free: 66 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0008821/0.6484, allocations: 325.9 kB / 0.7533 GB, free: 65.95 MB / 0.5762 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0002828/0.6487, allocations: 69.25 kB / 0.7534 GB, free: 65.95 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=42): time 2.585e-06/0.6487, allocations: 0.6562 kB / 0.7534 GB, free: 65.95 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=42): time 0.00333/0.652, allocations: 1.232 MB / 0.7546 GB, free: 65.61 MB / 0.5762 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.391e-05/0.6521, allocations: 59.92 kB / 0.7546 GB, free: 65.54 MB / 0.5762 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002651/0.6547, allocations: 1.895 MB / 0.7565 GB, free: 64.83 MB / 0.5762 GB
Notification: Performance of collectPreVariables (initialization): time 5.783e-05/0.6548, allocations: 39.67 kB / 0.7565 GB, free: 64.79 MB / 0.5762 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00056/0.6554, allocations: 0.7926 MB / 0.7573 GB, free: 64.23 MB / 0.5762 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001154/0.6555, allocations: 150.1 kB / 0.7574 GB, free: 64.12 MB / 0.5762 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000394/0.6559, allocations: 266.8 kB / 0.7577 GB, free: 64 MB / 0.5762 GB
Notification: Performance of setup shared object (initialization): time 9.803e-05/0.656, allocations: 354.3 kB / 0.758 GB, free: 63.67 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008977/0.6569, allocations: 463.2 kB / 0.7585 GB, free: 63.51 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001132/0.658, allocations: 0.8359 MB / 0.7593 GB, free: 62.9 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001974/0.66, allocations: 1.163 MB / 0.7604 GB, free: 62.23 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.378e-06/0.66, allocations: 2.469 kB / 0.7604 GB, free: 62.23 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=150) (initialization): time 0.003245/0.6633, allocations: 1.597 MB / 0.762 GB, free: 61.61 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 4.11e-05/0.6633, allocations: 36.33 kB / 0.762 GB, free: 61.57 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.692e-05/0.6634, allocations: 8.531 kB / 0.762 GB, free: 61.57 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006607/0.664, allocations: 187.5 kB / 0.7622 GB, free: 61.54 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007674/0.6648, allocations: 200.2 kB / 0.7624 GB, free: 61.52 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0007091/0.6655, allocations: 0.7582 MB / 0.7631 GB, free: 60.93 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001036/0.6666, allocations: 70.89 kB / 0.7632 GB, free: 60.91 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001229/0.6667, allocations: 48.89 kB / 0.7633 GB, free: 60.91 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001467/0.6682, allocations: 0.8699 MB / 0.7641 GB, free: 60.53 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0009197/0.6691, allocations: 0.8216 MB / 0.7649 GB, free: 59.91 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001454/0.6706, allocations: 1.132 MB / 0.766 GB, free: 59.23 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.903e-06/0.6706, allocations: 2.75 kB / 0.766 GB, free: 59.23 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=150) (initialization_lambda0): time 0.002486/0.6731, allocations: 1.58 MB / 0.7676 GB, free: 58.53 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 2.928e-05/0.6731, allocations: 38.12 kB / 0.7676 GB, free: 58.5 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.164e-05/0.6731, allocations: 9.125 kB / 0.7676 GB, free: 58.5 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002066/0.6734, allocations: 102.2 kB / 0.7677 GB, free: 58.48 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006557/0.674, allocations: 194.8 kB / 0.7679 GB, free: 58.46 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00196/0.676, allocations: 2.367 MB / 0.7702 GB, free: 56.55 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009928/0.677, allocations: 79.5 kB / 0.7703 GB, free: 56.53 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.342e-05/0.6771, allocations: 44.69 kB / 0.7703 GB, free: 56.52 MB / 0.5762 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 38
 * Number of states: 0 ()
 * Number of discrete variables: 7 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,nRes.y,from_dp.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (105):
 * Single equations (assignments): 101
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
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
   {(5,7)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003037/0.6774, allocations: 248.5 kB / 0.7706 GB, free: 56.3 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002188/0.6776, allocations: 165.8 kB / 0.7707 GB, free: 56.21 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002142/0.6798, allocations: 0.9068 MB / 0.7716 GB, free: 55.87 MB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001451/0.6812, allocations: 0.9053 MB / 0.7725 GB, free: 55.31 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.015e-06/0.6813, allocations: 0 / 0.7725 GB, free: 55.31 MB / 0.5762 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004526/0.6817, allocations: 320.4 kB / 0.7728 GB, free: 55.07 MB / 0.5762 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001728/0.6819, allocations: 7.641 kB / 0.7728 GB, free: 55.07 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006192/0.6825, allocations: 48.72 kB / 0.7728 GB, free: 55.06 MB / 0.5762 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001361/0.6827, allocations: 47.62 kB / 0.7729 GB, free: 55.05 MB / 0.5762 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001976/0.6846, allocations: 0.8142 MB / 0.7737 GB, free: 54.75 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.002041/0.6867, allocations: 1.175 MB / 0.7748 GB, free: 54.19 MB / 0.5762 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0005827/0.6873, allocations: 274.1 kB / 0.7751 GB, free: 54.11 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.001829/0.6891, allocations: 1.293 MB / 0.7764 GB, free: 53.61 MB / 0.5762 GB
Notification: Performance of Backend: time 2.81e-07/0.6891, allocations: 0 / 0.7764 GB, free: 53.61 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.004535/0.6937, allocations: 2.197 MB / 0.7785 GB, free: 52.75 MB / 0.5762 GB
Notification: Performance of SimCode: time 0.005481/0.6992, allocations: 3.996 MB / 0.7824 GB, free: 50.71 MB / 0.5762 GB
Notification: Performance of Templates: time 0.04951/0.7487, allocations: 37.32 MB / 0.8188 GB, free: 16.81 MB / 0.5762 GB
make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2.makefile
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2.sim & ./BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example2.pipe 2>&1)