Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_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 11.0.0-master/package.mo", uses=false)
Using package Buildings with version 11.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/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_latest_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_latest_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.001094/0.001094, allocations: 99.58 kB / 16.02 MB, free: 76 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001642/0.001642, allocations: 189.1 kB / 16.92 MB, free: 6.746 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.328/1.328, allocations: 223.3 MB / 241 MB, free: 5.371 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.0-master/package.mo): time 2.613/2.613, allocations: 462.6 MB / 0.737 GB, free: 15.58 MB / 0.5919 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003405/0.0003405, allocations: 8.531 kB / 0.9034 GB, free: 36.45 MB / 0.7169 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2843/0.2846, allocations: 159.6 MB / 1.059 GB, free: 4.996 MB / 0.8106 GB
Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 3.283/3.567, allocations: 1.342 GB / 2.401 GB, free: 54.61 MB / 1.498 GB
Notification: Performance of NFInst.instExpressions: time 0.3515/3.919, allocations: 331.1 MB / 2.725 GB, free: 4.457 MB / 1.498 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0538/3.973, allocations: 1.051 MB / 2.726 GB, free: 3.398 MB / 1.498 GB
Notification: Performance of NFTyping.typeComponents: time 0.03809/4.011, allocations: 10.82 MB / 2.736 GB, free: 9.012 MB / 1.514 GB
Notification: Performance of NFTyping.typeBindings: time 0.09937/4.11, allocations: 29.44 MB / 2.765 GB, free: 136 kB / 1.529 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04965/4.16, allocations: 18.13 MB / 2.783 GB, free: 12 kB / 1.545 GB
Notification: Performance of NFFlatten.flatten: time 0.09312/4.253, allocations: 75.87 MB / 2.857 GB, free: 6.062 MB / 1.623 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0441/4.297, allocations: 18.4 MB / 2.875 GB, free: 3.801 MB / 1.639 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05495/4.352, allocations: 20.28 MB / 2.895 GB, free: 0.5352 MB / 1.654 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03422/4.386, allocations: 16.91 MB / 2.911 GB, free: 0.7617 MB / 1.67 GB
Notification: Performance of NFPackage.collectConstants: time 0.007145/4.394, allocations: 0.6328 MB / 2.912 GB, free: 132 kB / 1.67 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04462/4.438, allocations: 15.58 MB / 2.927 GB, free: 1.258 MB / 1.686 GB
Notification: Performance of NFScalarize.scalarize: time 0.008467/4.447, allocations: 3.262 MB / 2.93 GB, free: 14.05 MB / 1.701 GB
Notification: Performance of NFVerifyModel.verify: time 0.02373/4.47, allocations: 9.338 MB / 2.939 GB, free: 4.73 MB / 1.701 GB
Notification: Performance of NFConvertDAE.convert: time 0.04851/4.519, allocations: 33.12 MB / 2.972 GB, free: 4.738 MB / 1.732 GB
Notification: Performance of FrontEnd - DAE generated: time 7.153e-06/4.519, allocations: 0 / 2.972 GB, free: 4.738 MB / 1.732 GB
Notification: Performance of FrontEnd: time 2.855e-06/4.519, allocations: 3.938 kB / 2.972 GB, free: 4.734 MB / 1.732 GB
Notification: Performance of Transformations before backend: time 0.001096/4.52, allocations: 4 kB / 2.972 GB, free: 4.73 MB / 1.732 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3233
 * Number of variables: 3233
Notification: Performance of Generate backend data structure: time 1.118/5.638, allocations: 16.76 MB / 2.988 GB, free: 0.8529 GB / 1.733 GB
Notification: Performance of prepare preOptimizeDAE: time 4.622e-05/5.638, allocations: 12.59 kB / 2.988 GB, free: 0.8529 GB / 1.733 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.008868/5.647, allocations: 2.253 MB / 2.99 GB, free: 0.8519 GB / 1.733 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04295/5.69, allocations: 18.07 MB / 3.008 GB, free: 0.8464 GB / 1.733 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001215/5.691, allocations: 0.9717 MB / 3.009 GB, free: 0.8459 GB / 1.733 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003915/5.695, allocations: 1.289 MB / 3.01 GB, free: 0.8455 GB / 1.733 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03922/5.735, allocations: 14.49 MB / 3.024 GB, free: 0.8383 GB / 1.733 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000543/5.735, allocations: 47.38 kB / 3.024 GB, free: 0.8383 GB / 1.733 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002471/5.738, allocations: 0.5322 MB / 3.025 GB, free: 0.8379 GB / 1.733 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003967/5.738, allocations: 340.4 kB / 3.025 GB, free: 0.8379 GB / 1.733 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01953/5.758, allocations: 10.09 MB / 3.035 GB, free: 0.8328 GB / 1.733 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.08583/5.843, allocations: 74.81 MB / 3.108 GB, free: 0.769 GB / 1.733 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006389/5.85, allocations: 4.576 MB / 3.112 GB, free: 0.7664 GB / 1.733 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003359/5.853, allocations: 2.439 MB / 3.115 GB, free: 0.765 GB / 1.733 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.07492/5.928, allocations: 51.89 MB / 3.166 GB, free: 0.7136 GB / 1.733 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001826/5.928, allocations: 122.2 kB / 3.166 GB, free: 0.7135 GB / 1.733 GB
Notification: Performance of pre-optimization done (n=412): time 7.084e-06/5.928, allocations: 0 / 3.166 GB, free: 0.7135 GB / 1.733 GB
Notification: Performance of matching and sorting (n=412): time 0.01469/5.943, allocations: 6.983 MB / 3.172 GB, free: 0.7066 GB / 1.733 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001763/5.943, allocations: 0.791 MB / 3.173 GB, free: 0.7057 GB / 1.733 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03097/5.974, allocations: 16.43 MB / 3.189 GB, free: 0.6898 GB / 1.733 GB
Notification: Performance of collectPreVariables (initialization): time 0.00123/5.976, allocations: 141.7 kB / 3.189 GB, free: 0.6896 GB / 1.733 GB
Notification: Performance of collectInitialEqns (initialization): time 0.008444/5.984, allocations: 8.656 MB / 3.198 GB, free: 0.6811 GB / 1.733 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002111/5.986, allocations: 1.457 MB / 3.199 GB, free: 0.6797 GB / 1.733 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009952/5.987, allocations: 0.5039 MB / 3.2 GB, free: 0.6792 GB / 1.733 GB
Notification: Performance of setup shared object (initialization): time 5.051e-05/5.987, allocations: 301.1 kB / 3.2 GB, free: 0.6789 GB / 1.733 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00315/5.99, allocations: 2.043 MB / 3.202 GB, free: 0.6769 GB / 1.733 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004866/5.995, allocations: 5.094 MB / 3.207 GB, free: 0.6708 GB / 1.733 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007245/6.003, allocations: 6.882 MB / 3.214 GB, free: 0.6631 GB / 1.733 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.328e-05/6.003, allocations: 24 kB / 3.214 GB, free: 0.6631 GB / 1.733 GB
Notification: Performance of matching and sorting (n=821) (initialization): time 0.0165/6.019, allocations: 8.14 MB / 3.222 GB, free: 0.6551 GB / 1.733 GB
Notification: Performance of prepare postOptimizeDAE: time 6.142e-05/6.019, allocations: 43.94 kB / 3.222 GB, free: 0.6551 GB / 1.733 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.646e-05/6.019, allocations: 72 kB / 3.222 GB, free: 0.655 GB / 1.733 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001/6.019, allocations: 112 kB / 3.222 GB, free: 0.6549 GB / 1.733 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00449/6.024, allocations: 1.412 MB / 3.223 GB, free: 0.6535 GB / 1.733 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001107/6.024, allocations: 159.4 kB / 3.223 GB, free: 0.6534 GB / 1.733 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01324/6.037, allocations: 1.867 MB / 3.225 GB, free: 0.6516 GB / 1.733 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001369/6.039, allocations: 379.9 kB / 3.226 GB, free: 0.6512 GB / 1.733 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 341
 * 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 (821):
 * Single equations (assignments): 821
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.007929/6.047, allocations: 3.557 MB / 3.229 GB, free: 0.6477 GB / 1.733 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004334/6.051, allocations: 1.663 MB / 3.231 GB, free: 0.6461 GB / 1.733 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01353/6.065, allocations: 7.565 MB / 3.238 GB, free: 0.6389 GB / 1.733 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001564/6.065, allocations: 83.94 kB / 3.238 GB, free: 0.6388 GB / 1.733 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 2.751e-05/6.065, allocations: 12 kB / 3.238 GB, free: 0.6388 GB / 1.733 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003638/6.068, allocations: 3.834 MB / 3.242 GB, free: 0.6347 GB / 1.733 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04294/6.111, allocations: 28.72 MB / 3.27 GB, free: 0.6063 GB / 1.733 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.533e-05/6.112, allocations: 32 kB / 3.27 GB, free: 0.6063 GB / 1.733 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002716/6.114, allocations: 0.7724 MB / 3.271 GB, free: 0.6055 GB / 1.733 GB
Notification: Performance of postOpt tearingSystem (simulation): time 5.218e-05/6.114, allocations: 52 kB / 3.271 GB, free: 0.6055 GB / 1.733 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004095/6.115, allocations: 155.9 kB / 3.271 GB, free: 0.6053 GB / 1.733 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 4.068e-05/6.115, allocations: 67.8 kB / 3.271 GB, free: 0.6053 GB / 1.733 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.054e-05/6.115, allocations: 47.75 kB / 3.271 GB, free: 0.6052 GB / 1.733 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01446/6.129, allocations: 11.95 MB / 3.283 GB, free: 0.593 GB / 1.733 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007949/6.137, allocations: 3.132 MB / 3.286 GB, free: 0.5899 GB / 1.733 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004284/6.142, allocations: 132 kB / 3.286 GB, free: 0.5897 GB / 1.733 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01049/6.152, allocations: 0.6076 MB / 3.287 GB, free: 0.5892 GB / 1.733 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008408/6.153, allocations: 405.2 kB / 3.287 GB, free: 0.5888 GB / 1.733 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0005761/6.154, allocations: 259.8 kB / 3.287 GB, free: 0.5885 GB / 1.733 GB
Notification: Performance of sorting global known variables: time 0.02233/6.176, allocations: 11.7 MB / 3.299 GB, free: 0.5772 GB / 1.733 GB
Notification: Performance of sort global known variables: time 6.21e-07/6.176, allocations: 0 / 3.299 GB, free: 0.5772 GB / 1.733 GB
Notification: Performance of remove unused functions: time 0.01919/6.195, allocations: 5.289 MB / 3.304 GB, free: 0.5723 GB / 1.733 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 ($cse12.phase,$cse12.region,$cse3.phase,$cse3.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 (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.01143/6.207, allocations: 4.697 MB / 3.308 GB, free: 0.5683 GB / 1.733 GB
Notification: Performance of simCode: created initialization part: time 0.009072/6.216, allocations: 5.506 MB / 3.314 GB, free: 0.5629 GB / 1.733 GB
Notification: Performance of simCode: created event and clocks part: time 3.552e-05/6.216, allocations: 10.25 kB / 3.314 GB, free: 0.5629 GB / 1.733 GB
Notification: Performance of simCode: created simulation system equations: time 0.003754/6.22, allocations: 2.58 MB / 3.316 GB, free: 0.5604 GB / 1.733 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.1671/6.387, allocations: 12.42 MB / 3.328 GB, free: 0.5488 GB / 1.733 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05152/6.438, allocations: 34.09 MB / 3.362 GB, free: 0.5151 GB / 1.733 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01149/6.45, allocations: 7.545 MB / 3.369 GB, free: 0.5077 GB / 1.733 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.006571/6.456, allocations: 1.632 MB / 3.371 GB, free: 0.5061 GB / 1.733 GB
Notification: Performance of SimCode: time 1.833e-06/6.456, allocations: 0 / 3.371 GB, free: 0.5061 GB / 1.733 GB
Notification: Performance of Templates: time 0.3708/6.827, allocations: 316.3 MB / 3.68 GB, free: 203.2 MB / 1.733 GB
make -j1 -f Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.makefile
(rm -f Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & ./Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Experimental_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches