Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.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/Buildings 9.1.2-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.2-maint.9.1.x/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(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|buiTesOutETS.PHea|buiTesOutETS.PCoo|buiTesOutETS.PFan|buiTesOutETS.PPum|buiTesOutETSBui.QHea_flow|buiTesOutETSBui.QCoo_flow|buiTesOutETSBui.PHea|buiTesOutETSBui.PCoo|buiTesOutETSBui.PFan|buiTesOutETSBui.PPum|buiTesFacMul.PHea|buiTesFacMul.PCoo|buiTesFacMul.PFan|buiTesFacMul.PPum|buiTesFacMul.QHea_flow|buiTesFacMul.QCoo_flow",fileNamePrefix="Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS")
translateModel(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|buiTesOutETS.PHea|buiTesOutETS.PCoo|buiTesOutETS.PFan|buiTesOutETS.PPum|buiTesOutETSBui.QHea_flow|buiTesOutETSBui.QCoo_flow|buiTesOutETSBui.PHea|buiTesOutETSBui.PCoo|buiTesOutETSBui.PFan|buiTesOutETSBui.PPum|buiTesFacMul.PHea|buiTesFacMul.PCoo|buiTesFacMul.PFan|buiTesFacMul.PPum|buiTesFacMul.QHea_flow|buiTesFacMul.QCoo_flow",fileNamePrefix="Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001197/0.001197, allocations: 100.9 kB / 15.05 MB, free: 1.105 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.001469/0.001469, allocations: 177.3 kB / 15.94 MB, free: 228 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.466/1.466, allocations: 223.2 MB / 239.9 MB, free: 5.352 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.2-maint.9.1.x/package.mo): time 2.438/2.438, allocations: 390.3 MB / 0.6653 GB, free: 2.938 MB / 0.5138 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004531/0.0004534, allocations: 11.94 kB / 0.8145 GB, free: 14.31 MB / 0.67 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.9733/0.9738, allocations: 142.3 MB / 0.9535 GB, free: 8.09 MB / 0.7169 GB
Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 2.708/3.682, allocations: 1.131 GB / 2.085 GB, free: 15.26 MB / 1.264 GB
Notification: Performance of NFInst.instExpressions: time 1.512/5.194, allocations: 283.9 MB / 2.362 GB, free: 51.44 MB / 1.42 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.05122/5.245, allocations: 0.9588 MB / 2.363 GB, free: 51.44 MB / 1.42 GB
Notification: Performance of NFTyping.typeComponents: time 0.06031/5.306, allocations: 13.42 MB / 2.376 GB, free: 51.42 MB / 1.42 GB
Notification: Performance of NFTyping.typeBindings: time 0.1365/5.442, allocations: 33.81 MB / 2.409 GB, free: 51.05 MB / 1.42 GB
Notification: Performance of NFTyping.typeClassSections: time 0.07281/5.515, allocations: 25.01 MB / 2.433 GB, free: 49.88 MB / 1.42 GB
Notification: Performance of NFFlatten.flatten: time 0.07469/5.59, allocations: 30.63 MB / 2.463 GB, free: 48.47 MB / 1.42 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03705/5.627, allocations: 14.1 MB / 2.477 GB, free: 43.79 MB / 1.42 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05391/5.681, allocations: 17.41 MB / 2.494 GB, free: 41.43 MB / 1.42 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03261/5.713, allocations: 13.86 MB / 2.508 GB, free: 39.64 MB / 1.42 GB
Notification: Performance of NFPackage.collectConstants: time 0.009654/5.723, allocations: 0.6185 MB / 2.508 GB, free: 39.64 MB / 1.42 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04931/5.772, allocations: 13.06 MB / 2.521 GB, free: 37.42 MB / 1.42 GB
Notification: Performance of NFScalarize.scalarize: time 0.009416/5.782, allocations: 2.893 MB / 2.524 GB, free: 36.55 MB / 1.42 GB
Notification: Performance of NFVerifyModel.verify: time 0.01566/5.797, allocations: 4.075 MB / 2.528 GB, free: 34.78 MB / 1.42 GB
Notification: Performance of NFConvertDAE.convert: time 0.04866/5.846, allocations: 31.15 MB / 2.558 GB, free: 8.242 MB / 1.42 GB
Notification: Performance of FrontEnd - DAE generated: time 3.737e-06/5.846, allocations: 0 / 2.558 GB, free: 8.242 MB / 1.42 GB
Notification: Performance of FrontEnd: time 2.244e-06/5.846, allocations: 2.625 kB / 2.558 GB, free: 8.242 MB / 1.42 GB
Notification: Performance of Transformations before backend: time 0.001278/5.848, allocations: 0 / 2.558 GB, free: 8.242 MB / 1.42 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3135
 * Number of variables: 3135
Notification: Performance of Generate backend data structure: time 0.04066/5.888, allocations: 16.58 MB / 2.574 GB, free: 9.367 MB / 1.436 GB
Notification: Performance of prepare preOptimizeDAE: time 4.58e-05/5.888, allocations: 8.031 kB / 2.574 GB, free: 9.359 MB / 1.436 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009767/5.898, allocations: 2.181 MB / 2.577 GB, free: 7.16 MB / 1.436 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03903/5.937, allocations: 16.41 MB / 2.593 GB, free: 13.56 MB / 1.451 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001067/5.938, allocations: 0.9463 MB / 2.594 GB, free: 13.01 MB / 1.451 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004089/5.942, allocations: 1.255 MB / 2.595 GB, free: 12.16 MB / 1.451 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04053/5.983, allocations: 13.77 MB / 2.608 GB, free: 2.457 MB / 1.451 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006111/5.983, allocations: 44.53 kB / 2.608 GB, free: 2.438 MB / 1.451 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002974/5.986, allocations: 0.5054 MB / 2.609 GB, free: 2.316 MB / 1.451 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003466/5.987, allocations: 342.7 kB / 2.609 GB, free: 1.996 MB / 1.451 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02225/6.009, allocations: 9.59 MB / 2.618 GB, free: 12.19 MB / 1.467 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.09212/6.101, allocations: 70.82 MB / 2.688 GB, free: 2.32 MB / 1.514 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007142/6.108, allocations: 4.553 MB / 2.692 GB, free: 15 MB / 1.529 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.08638/6.195, allocations: 51.84 MB / 2.743 GB, free: 4.77 MB / 1.576 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002118/6.195, allocations: 121.2 kB / 2.743 GB, free: 4.68 MB / 1.576 GB
Notification: Performance of pre-optimization done (n=412): time 7.705e-06/6.195, allocations: 0 / 2.743 GB, free: 4.68 MB / 1.576 GB
Notification: Performance of matching and sorting (n=412): time 0.01692/6.212, allocations: 6.901 MB / 2.75 GB, free: 15.59 MB / 1.592 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003891/6.212, allocations: 0.795 MB / 2.75 GB, free: 14.62 MB / 1.592 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03858/6.251, allocations: 16.23 MB / 2.766 GB, free: 3.582 MB / 1.592 GB
Notification: Performance of collectPreVariables (initialization): time 0.00238/6.253, allocations: 141 kB / 2.766 GB, free: 3.508 MB / 1.592 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0153/6.269, allocations: 8.284 MB / 2.774 GB, free: 72 kB / 1.592 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002818/6.272, allocations: 1.448 MB / 2.776 GB, free: 14.84 MB / 1.608 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006729/6.272, allocations: 119.9 kB / 2.776 GB, free: 14.81 MB / 1.608 GB
Notification: Performance of setup shared object (initialization): time 0.0003961/6.273, allocations: 0.541 MB / 2.776 GB, free: 14.36 MB / 1.608 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003437/6.276, allocations: 1.946 MB / 2.778 GB, free: 13.16 MB / 1.608 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00559/6.282, allocations: 4.681 MB / 2.783 GB, free: 8.352 MB / 1.608 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004675/6.286, allocations: 2.782 MB / 2.786 GB, free: 6.746 MB / 1.608 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.931e-05/6.287, allocations: 22.84 kB / 2.786 GB, free: 6.727 MB / 1.608 GB
Notification: Performance of matching and sorting (n=775) (initialization): time 0.01815/6.305, allocations: 7.699 MB / 2.793 GB, free: 15.03 MB / 1.623 GB
Notification: Performance of prepare postOptimizeDAE: time 6.946e-05/6.305, allocations: 33.56 kB / 2.793 GB, free: 15 MB / 1.623 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.192e-05/6.305, allocations: 64 kB / 2.793 GB, free: 14.93 MB / 1.623 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001247/6.305, allocations: 108.8 kB / 2.793 GB, free: 14.83 MB / 1.623 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004906/6.31, allocations: 1.33 MB / 2.795 GB, free: 13.5 MB / 1.623 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001874/6.31, allocations: 143.5 kB / 2.795 GB, free: 13.36 MB / 1.623 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01362/6.324, allocations: 1.713 MB / 2.796 GB, free: 11.64 MB / 1.623 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001695/6.325, allocations: 355.9 kB / 2.797 GB, free: 11.29 MB / 1.623 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 295
 * Number of states: 0 ()
 * Number of discrete variables: 4 (senDifEntFlo1.state_b1_inflow.phase,senDifEntFlo1.state_a1_inflow.phase,senDifEntFlo.state_b1_inflow.phase,senDifEntFlo.state_a1_inflow.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (775):
 * Single equations (assignments): 775
 * 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.01033/6.336, allocations: 3.391 MB / 2.8 GB, free: 7.887 MB / 1.623 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005202/6.341, allocations: 1.613 MB / 2.802 GB, free: 6.254 MB / 1.623 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01939/6.36, allocations: 7.536 MB / 2.809 GB, free: 14.86 MB / 1.639 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0005887/6.361, allocations: 86.12 kB / 2.809 GB, free: 14.78 MB / 1.639 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.802e-05/6.361, allocations: 12 kB / 2.809 GB, free: 14.77 MB / 1.639 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007432/6.369, allocations: 3.822 MB / 2.813 GB, free: 10.63 MB / 1.639 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.06168/6.43, allocations: 28.55 MB / 2.841 GB, free: 13.71 MB / 1.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001203/6.431, allocations: 28 kB / 2.841 GB, free: 13.69 MB / 1.67 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003241/6.434, allocations: 0.7802 MB / 2.842 GB, free: 12.91 MB / 1.67 GB
Notification: Performance of postOpt tearingSystem (simulation): time 9.505e-05/6.434, allocations: 56 kB / 2.842 GB, free: 12.85 MB / 1.67 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0007038/6.435, allocations: 152 kB / 2.842 GB, free: 12.7 MB / 1.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.24e-05/6.435, allocations: 71.72 kB / 2.842 GB, free: 12.63 MB / 1.67 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.444e-05/6.435, allocations: 51.77 kB / 2.842 GB, free: 12.58 MB / 1.67 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03085/6.466, allocations: 28.16 MB / 2.869 GB, free: 14.32 MB / 1.701 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01246/6.478, allocations: 3.195 MB / 2.872 GB, free: 11.09 MB / 1.701 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005652/6.484, allocations: 132 kB / 2.873 GB, free: 10.96 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01161/6.495, allocations: 0.5471 MB / 2.873 GB, free: 10.42 MB / 1.701 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001221/6.497, allocations: 402.7 kB / 2.874 GB, free: 10.02 MB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001226/6.498, allocations: 256.4 kB / 2.874 GB, free: 9.773 MB / 1.701 GB
Notification: Performance of sorting global known variables: time 1.197/7.695, allocations: 11.55 MB / 2.885 GB, free: 0.8753 GB / 1.701 GB
Notification: Performance of sort global known variables: time 8.52e-07/7.695, allocations: 1.031 kB / 2.885 GB, free: 0.8753 GB / 1.701 GB
Notification: Performance of remove unused functions: time 0.02748/7.722, allocations: 5.278 MB / 2.89 GB, free: 0.8753 GB / 1.701 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 141
 * Number of states: 15 (buiTesFacMul.bui.loaHea.vol.dynBal.U,buiTesFacMul.bui.loaCoo.vol.dynBal.U,buiTesOutETSBui.bui.loaHea.vol.dynBal.U,buiTesOutETSBui.bui.loaCoo.vol.dynBal.U,buiTesOutETS.bui.loaHea.vol.dynBal.U,buiTesOutETS.bui.loaCoo.vol.dynBal.U,buiComGen5.bui.loaHea.vol.dynBal.U,buiComGen5.bui.loaCoo.vol.dynBal.U,buiHeaGen2to4.bui.loaHea.vol.dynBal.U,buiComGen2to4.bui.loaHea.vol.dynBal.U,buiComGen2to4.bui.loaCoo.vol.dynBal.U,buiCoo.bui.loaCoo.vol.dynBal.U,buiComGen1.bui.loaHea.vol.dynBal.U,buiComGen1.bui.loaCoo.vol.dynBal.U,buiHeaGen1.bui.loaHea.vol.dynBal.U)
 * Number of discrete variables: 4 ($cse16.phase,$cse16.region,$cse7.phase,$cse7.region)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (478):
 * Single equations (assignments): 412
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 66
 * 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.0155/7.738, allocations: 4.734 MB / 2.895 GB, free: 0.8747 GB / 1.701 GB
Notification: Performance of simCode: created initialization part: time 0.0117/7.75, allocations: 5.302 MB / 2.9 GB, free: 0.8745 GB / 1.701 GB
Notification: Performance of simCode: created event and clocks part: time 4.008e-05/7.75, allocations: 6.531 kB / 2.9 GB, free: 0.8745 GB / 1.701 GB
Notification: Performance of simCode: created simulation system equations: time 0.004524/7.754, allocations: 2.566 MB / 2.903 GB, free: 0.8743 GB / 1.701 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04704/7.801, allocations: 9.318 MB / 2.912 GB, free: 0.8741 GB / 1.701 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05425/7.856, allocations: 31.49 MB / 2.942 GB, free: 0.8575 GB / 1.701 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01236/7.868, allocations: 7.738 MB / 2.95 GB, free: 0.856 GB / 1.701 GB
Notification: Performance of simCode: alias equations: time 0.01661/7.885, allocations: 3.143 MB / 2.953 GB, free: 0.8557 GB / 1.701 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004248/7.889, allocations: 1.046 MB / 2.954 GB, free: 0.8557 GB / 1.701 GB
Notification: Performance of SimCode: time 7.11e-07/7.889, allocations: 0 / 2.954 GB, free: 0.8557 GB / 1.701 GB
Notification: Performance of Templates: time 0.4402/8.329, allocations: 337.4 MB / 3.284 GB, free: 0.5503 GB / 1.701 GB
make -j1 -f Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.makefile
(rm -f Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & ./Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Experimental_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","../files/Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches