Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3.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.Example3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3")
translateModel(BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001093/0.001093, allocations: 119.8 kB / 16.42 MB, free: 6.496 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.001103/0.001103, allocations: 187.9 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.355/1.355, allocations: 222.9 MB / 241 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.8881/0.8881, allocations: 143.1 MB / 434.3 MB, free: 12.01 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001193/0.001193, allocations: 63.59 kB / 0.5962 GB, free: 12.29 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1654/0.1666, allocations: 82.03 MB / 0.6763 GB, free: 10.34 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.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.Example3): time 0.03335/0.2, allocations: 33.27 MB / 0.7088 GB, free: 8.953 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.01735/0.2174, allocations: 12.37 MB / 0.7209 GB, free: 12.55 MB / 0.5606 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001973/0.2194, allocations: 59.69 kB / 0.7209 GB, free: 12.49 MB / 0.5606 GB
Notification: Performance of NFTyping.typeComponents: time 0.00398/0.2234, allocations: 1.543 MB / 0.7224 GB, free: 10.94 MB / 0.5606 GB
Notification: Performance of NFTyping.typeBindings: time 0.004373/0.2278, allocations: 1.796 MB / 0.7242 GB, free: 9.137 MB / 0.5606 GB
Notification: Performance of NFTyping.typeClassSections: time 0.00353/0.2313, allocations: 1.499 MB / 0.7256 GB, free: 7.645 MB / 0.5606 GB
Notification: Performance of NFFlatten.flatten: time 0.01016/0.2415, allocations: 7.829 MB / 0.7333 GB, free: 15.8 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003078/0.2446, allocations: 2.113 MB / 0.7354 GB, free: 13.64 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003928/0.2486, allocations: 1.961 MB / 0.7373 GB, free: 11.68 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002368/0.2509, allocations: 1.448 MB / 0.7387 GB, free: 10.22 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005174/0.2515, allocations: 152 kB / 0.7388 GB, free: 10.07 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.003067/0.2546, allocations: 1.346 MB / 0.7401 GB, free: 8.727 MB / 0.5762 GB
Notification: Performance of NFScalarize.scalarize: time 0.0008125/0.2554, allocations: 0.6111 MB / 0.7407 GB, free: 8.113 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.001958/0.2574, allocations: 1.212 MB / 0.7419 GB, free: 6.895 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.005291/0.2627, allocations: 3.707 MB / 0.7455 GB, free: 3.176 MB / 0.5762 GB
Notification: Performance of FrontEnd - DAE generated: time 3.797e-06/0.2627, allocations: 0 / 0.7455 GB, free: 3.176 MB / 0.5762 GB
Notification: Performance of FrontEnd: time 1.092e-06/0.2627, allocations: 0 / 0.7455 GB, free: 3.176 MB / 0.5762 GB
Notification: Performance of Transformations before backend: time 0.0001034/0.2628, allocations: 0 / 0.7455 GB, free: 3.176 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: 239
 * Number of variables: 239
Notification: Performance of Generate backend data structure: time 0.007694/0.2705, allocations: 2.837 MB / 0.7483 GB, free: 272 kB / 0.5762 GB
Notification: Performance of prepare preOptimizeDAE: time 5.628e-05/0.2706, allocations: 8.031 kB / 0.7483 GB, free: 264 kB / 0.5762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.3309/0.6015, allocations: 434 kB / 0.7487 GB, free: 70.07 MB / 0.5762 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005189/0.6067, allocations: 2.77 MB / 0.7514 GB, free: 69.61 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.041e-05/0.6068, allocations: 87.56 kB / 0.7515 GB, free: 69.56 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001725/0.607, allocations: 107.3 kB / 0.7516 GB, free: 69.53 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002213/0.6092, allocations: 1.317 MB / 0.7529 GB, free: 68.92 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.632e-05/0.6092, allocations: 8.531 kB / 0.7529 GB, free: 68.91 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.975e-05/0.6093, allocations: 38.94 kB / 0.753 GB, free: 68.88 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.97e-05/0.6094, allocations: 24.47 kB / 0.753 GB, free: 68.88 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002113/0.6115, allocations: 1.018 MB / 0.754 GB, free: 68.55 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.008218/0.6197, allocations: 6.936 MB / 0.7608 GB, free: 63.52 MB / 0.5762 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00159/0.6213, allocations: 0.5918 MB / 0.7613 GB, free: 63.31 MB / 0.5762 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001049/0.6224, allocations: 408.8 kB / 0.7617 GB, free: 63.17 MB / 0.5762 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003224/0.6256, allocations: 1.774 MB / 0.7635 GB, free: 61.92 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0008338/0.6265, allocations: 353.3 kB / 0.7638 GB, free: 61.79 MB / 0.5762 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0005853/0.6271, allocations: 92.56 kB / 0.7639 GB, free: 61.74 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=44): time 3.566e-06/0.6271, allocations: 4.812 kB / 0.7639 GB, free: 61.74 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=44): time 0.003997/0.6311, allocations: 1.376 MB / 0.7652 GB, free: 61.24 MB / 0.5762 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.191e-05/0.6311, allocations: 61.34 kB / 0.7653 GB, free: 61.18 MB / 0.5762 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003744/0.6349, allocations: 2.409 MB / 0.7676 GB, free: 60.31 MB / 0.5762 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001113/0.635, allocations: 45.12 kB / 0.7677 GB, free: 60.27 MB / 0.5762 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007491/0.6358, allocations: 0.9944 MB / 0.7686 GB, free: 59.5 MB / 0.5762 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001363/0.6359, allocations: 161.2 kB / 0.7688 GB, free: 59.38 MB / 0.5762 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004028/0.6363, allocations: 299.5 kB / 0.7691 GB, free: 59.25 MB / 0.5762 GB
Notification: Performance of setup shared object (initialization): time 9.15e-05/0.6364, allocations: 360.6 kB / 0.7694 GB, free: 58.92 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009314/0.6374, allocations: 0.4985 MB / 0.7699 GB, free: 58.75 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001349/0.6387, allocations: 0.9879 MB / 0.7709 GB, free: 57.97 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00207/0.6408, allocations: 1.337 MB / 0.7722 GB, free: 57.14 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.967e-06/0.6408, allocations: 2.281 kB / 0.7722 GB, free: 57.14 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=164) (initialization): time 0.003347/0.6442, allocations: 1.806 MB / 0.774 GB, free: 56.43 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 3.847e-05/0.6442, allocations: 40.89 kB / 0.774 GB, free: 56.39 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.879e-05/0.6442, allocations: 15.48 kB / 0.774 GB, free: 56.39 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006365/0.6449, allocations: 180.3 kB / 0.7742 GB, free: 56.36 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007967/0.6457, allocations: 231.2 kB / 0.7744 GB, free: 56.33 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0005902/0.6463, allocations: 0.7582 MB / 0.7751 GB, free: 55.74 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001397/0.6477, allocations: 82.81 kB / 0.7752 GB, free: 55.71 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.832e-05/0.6478, allocations: 57.16 kB / 0.7753 GB, free: 55.7 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00155/0.6494, allocations: 1.032 MB / 0.7763 GB, free: 55.15 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0009941/0.6504, allocations: 0.9668 MB / 0.7772 GB, free: 54.27 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001581/0.652, allocations: 1.307 MB / 0.7785 GB, free: 53.31 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.374e-06/0.652, allocations: 10.64 kB / 0.7785 GB, free: 53.3 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=164) (initialization_lambda0): time 0.002967/0.655, allocations: 1.798 MB / 0.7803 GB, free: 52.32 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 3.132e-05/0.655, allocations: 36.42 kB / 0.7803 GB, free: 52.29 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.431e-05/0.655, allocations: 11.25 kB / 0.7803 GB, free: 52.29 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002301/0.6553, allocations: 124.7 kB / 0.7804 GB, free: 52.24 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007259/0.656, allocations: 213.4 kB / 0.7806 GB, free: 52.2 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00173/0.6577, allocations: 2.332 MB / 0.7829 GB, free: 50.16 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001431/0.6592, allocations: 83.39 kB / 0.783 GB, free: 50.13 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.962e-05/0.6593, allocations: 53.27 kB / 0.783 GB, free: 50.12 MB / 0.5762 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 50
 * Number of states: 0 ()
 * Number of discrete variables: 8 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,nRes.y,from_dp.y,mergeDp.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (118):
 * Single equations (assignments): 114
 * 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
   {(1,12)}
Notification: Performance of prepare postOptimizeDAE: time 0.0003/0.6596, allocations: 258.7 kB / 0.7833 GB, free: 49.89 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002602/0.6599, allocations: 215.9 kB / 0.7835 GB, free: 49.77 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002099/0.662, allocations: 1.028 MB / 0.7845 GB, free: 49.2 MB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001437/0.6634, allocations: 0.9682 MB / 0.7854 GB, free: 48.51 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.977e-06/0.6634, allocations: 0 / 0.7854 GB, free: 48.51 MB / 0.5762 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005525/0.664, allocations: 368.7 kB / 0.7858 GB, free: 48.21 MB / 0.5762 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002161/0.6642, allocations: 11.94 kB / 0.7858 GB, free: 48.2 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007118/0.6649, allocations: 43.42 kB / 0.7859 GB, free: 48.18 MB / 0.5762 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001079/0.6651, allocations: 51.98 kB / 0.7859 GB, free: 48.16 MB / 0.5762 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001821/0.6669, allocations: 0.8841 MB / 0.7868 GB, free: 47.68 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001916/0.6688, allocations: 1.308 MB / 0.788 GB, free: 46.9 MB / 0.5762 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0005495/0.6694, allocations: 304.8 kB / 0.7883 GB, free: 46.75 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.001935/0.6713, allocations: 1.645 MB / 0.7899 GB, free: 45.85 MB / 0.5762 GB
Notification: Performance of Backend: time 3.41e-07/0.6713, allocations: 0 / 0.7899 GB, free: 45.85 MB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.004246/0.6756, allocations: 2.33 MB / 0.7922 GB, free: 43.56 MB / 0.5762 GB
Notification: Performance of SimCode: time 0.006175/0.6818, allocations: 4.842 MB / 0.7969 GB, free: 38.71 MB / 0.5762 GB
Notification: Performance of Templates: time 0.05836/0.7402, allocations: 43.95 MB / 0.8399 GB, free: 11.31 MB / 0.5919 GB
make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3.makefile
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3.sim & ./BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.Performance.Example3.pipe 2>&1)