Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.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.1.0-maint.11.x/package.mo", uses=false)
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.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.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_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS")
translateModel(Buildings.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_11_Buildings.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.001965/0.001973, allocations: 115.3 kB / 15.34 MB, free: 0.5156 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.002034/0.002034, allocations: 194.9 kB / 16.25 MB, free: 6.637 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.528/1.528, allocations: 222.9 MB / 239.9 MB, free: 4.539 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 3.068/3.068, allocations: 469.8 MB / 0.742 GB, free: 7.621 MB / 0.5919 GB
Notification: Performance of FrontEnd - loaded program: time 0.00193/0.00193, allocations: 71.75 kB / 0.908 GB, free: 34.55 MB / 0.7169 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3718/0.3738, allocations: 159.2 MB / 1.063 GB, free: 14.62 MB / 0.8262 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 3.999/4.373, allocations: 1.356 GB / 2.42 GB, free: 84.84 MB / 1.561 GB
Notification: Performance of NFInst.instExpressions: time 0.3717/4.745, allocations: 331.1 MB / 2.743 GB, free: 25.1 MB / 1.561 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.05316/4.798, allocations: 1.118 MB / 2.744 GB, free: 23.97 MB / 1.561 GB
Notification: Performance of NFTyping.typeComponents: time 0.0346/4.833, allocations: 11.55 MB / 2.755 GB, free: 12.85 MB / 1.561 GB
Notification: Performance of NFTyping.typeBindings: time 0.08353/4.917, allocations: 29.97 MB / 2.785 GB, free: 3.43 MB / 1.576 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04865/4.965, allocations: 18.26 MB / 2.802 GB, free: 3.16 MB / 1.592 GB
Notification: Performance of NFFlatten.flatten: time 0.0849/5.05, allocations: 58.43 MB / 2.86 GB, free: 10.28 MB / 1.654 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04425/5.094, allocations: 23.01 MB / 2.882 GB, free: 3.391 MB / 1.67 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.06076/5.155, allocations: 24.98 MB / 2.906 GB, free: 11.84 MB / 1.701 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03658/5.192, allocations: 18.29 MB / 2.924 GB, free: 10.46 MB / 1.717 GB
Notification: Performance of NFPackage.collectConstants: time 0.009763/5.202, allocations: 2.129 MB / 2.926 GB, free: 8.328 MB / 1.717 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.05082/5.252, allocations: 18.03 MB / 2.944 GB, free: 6.27 MB / 1.732 GB
Notification: Performance of NFScalarize.scalarize: time 0.01047/5.263, allocations: 4.914 MB / 2.949 GB, free: 1.34 MB / 1.732 GB
Notification: Performance of NFVerifyModel.verify: time 0.027/5.29, allocations: 11.18 MB / 2.96 GB, free: 6.102 MB / 1.748 GB
Notification: Performance of NFConvertDAE.convert: time 0.07987/5.37, allocations: 40.71 MB / 2.999 GB, free: 13.29 MB / 1.795 GB
Notification: Performance of FrontEnd - DAE generated: time 5.84e-06/5.37, allocations: 0 / 2.999 GB, free: 13.29 MB / 1.795 GB
Notification: Performance of FrontEnd: time 1.873e-06/5.37, allocations: 0 / 2.999 GB, free: 13.29 MB / 1.795 GB
Notification: Performance of Transformations before backend: time 0.001207/5.371, allocations: 0 / 2.999 GB, free: 13.29 MB / 1.795 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 0.0576/5.429, allocations: 20.91 MB / 3.02 GB, free: 8.129 MB / 1.811 GB
Notification: Performance of prepare preOptimizeDAE: time 5.228e-05/5.429, allocations: 11.97 kB / 3.02 GB, free: 8.117 MB / 1.811 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01112/5.44, allocations: 2.245 MB / 3.022 GB, free: 5.848 MB / 1.811 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0474/5.487, allocations: 18.03 MB / 3.04 GB, free: 3.703 MB / 1.826 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001546/5.489, allocations: 0.9739 MB / 3.041 GB, free: 2.727 MB / 1.826 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00497/5.494, allocations: 1.285 MB / 3.042 GB, free: 1.441 MB / 1.826 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.7355/6.229, allocations: 14.49 MB / 3.056 GB, free: 0.9343 GB / 1.826 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0008493/6.23, allocations: 42.3 kB / 3.056 GB, free: 0.9343 GB / 1.826 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004497/6.235, allocations: 0.5342 MB / 3.057 GB, free: 0.9339 GB / 1.826 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004227/6.235, allocations: 341.5 kB / 3.057 GB, free: 0.9339 GB / 1.826 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02531/6.261, allocations: 10.08 MB / 3.067 GB, free: 0.93 GB / 1.826 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.09851/6.359, allocations: 74.72 MB / 3.14 GB, free: 0.8732 GB / 1.826 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006588/6.366, allocations: 4.57 MB / 3.144 GB, free: 0.8706 GB / 1.826 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002989/6.369, allocations: 2.422 MB / 3.147 GB, free: 0.8693 GB / 1.826 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.06926/6.438, allocations: 51.51 MB / 3.197 GB, free: 0.8261 GB / 1.826 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0001667/6.438, allocations: 116.7 kB / 3.197 GB, free: 0.8261 GB / 1.826 GB
Notification: Performance of pre-optimization done (n=412): time 1.146e-05/6.438, allocations: 0 / 3.197 GB, free: 0.8261 GB / 1.826 GB
Notification: Performance of matching and sorting (n=412): time 0.01464/6.453, allocations: 6.975 MB / 3.204 GB, free: 0.8227 GB / 1.826 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001903/6.453, allocations: 0.7944 MB / 3.205 GB, free: 0.8218 GB / 1.826 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03848/6.492, allocations: 16.44 MB / 3.221 GB, free: 0.8135 GB / 1.826 GB
Notification: Performance of collectPreVariables (initialization): time 0.001587/6.493, allocations: 145 kB / 3.221 GB, free: 0.8134 GB / 1.826 GB
Notification: Performance of collectInitialEqns (initialization): time 0.009678/6.503, allocations: 8.65 MB / 3.229 GB, free: 0.8056 GB / 1.826 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002211/6.505, allocations: 1.458 MB / 3.231 GB, free: 0.8041 GB / 1.826 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003976/6.509, allocations: 1.451 MB / 3.232 GB, free: 0.8027 GB / 1.826 GB
Notification: Performance of setup shared object (initialization): time 5.917e-05/6.509, allocations: 305.1 kB / 3.232 GB, free: 0.8024 GB / 1.826 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003272/6.513, allocations: 2.043 MB / 3.234 GB, free: 0.8004 GB / 1.826 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005221/6.518, allocations: 5.093 MB / 3.239 GB, free: 0.7943 GB / 1.826 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007196/6.525, allocations: 6.874 MB / 3.246 GB, free: 0.7867 GB / 1.826 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.081e-05/6.525, allocations: 31.94 kB / 3.246 GB, free: 0.7867 GB / 1.826 GB
Notification: Performance of matching and sorting (n=821) (initialization): time 0.01697/6.542, allocations: 8.157 MB / 3.254 GB, free: 0.7788 GB / 1.826 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001208/6.542, allocations: 40 kB / 3.254 GB, free: 0.7787 GB / 1.826 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001442/6.543, allocations: 72 kB / 3.254 GB, free: 0.7786 GB / 1.826 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001448/6.543, allocations: 112 kB / 3.254 GB, free: 0.7785 GB / 1.826 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004914/6.548, allocations: 1.408 MB / 3.256 GB, free: 0.7772 GB / 1.826 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001553/6.548, allocations: 159.4 kB / 3.256 GB, free: 0.777 GB / 1.826 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01516/6.563, allocations: 1.849 MB / 3.258 GB, free: 0.7752 GB / 1.826 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002151/6.565, allocations: 383.9 kB / 3.258 GB, free: 0.7748 GB / 1.826 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.01235/6.578, allocations: 3.555 MB / 3.261 GB, free: 0.7713 GB / 1.826 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006538/6.584, allocations: 1.647 MB / 3.263 GB, free: 0.7697 GB / 1.826 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0151/6.599, allocations: 7.567 MB / 3.27 GB, free: 0.7625 GB / 1.826 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001736/6.599, allocations: 87.94 kB / 3.27 GB, free: 0.7624 GB / 1.826 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.208e-05/6.599, allocations: 15.94 kB / 3.27 GB, free: 0.7624 GB / 1.826 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003789/6.603, allocations: 3.833 MB / 3.274 GB, free: 0.7583 GB / 1.826 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0508/6.654, allocations: 28.66 MB / 3.302 GB, free: 0.7299 GB / 1.826 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0002065/6.654, allocations: 32 kB / 3.302 GB, free: 0.7299 GB / 1.826 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003311/6.658, allocations: 0.7762 MB / 3.303 GB, free: 0.7291 GB / 1.826 GB
Notification: Performance of postOpt tearingSystem (simulation): time 7.532e-05/6.658, allocations: 52 kB / 3.303 GB, free: 0.7291 GB / 1.826 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0009431/6.659, allocations: 152 kB / 3.303 GB, free: 0.729 GB / 1.826 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.346e-05/6.659, allocations: 75.72 kB / 3.303 GB, free: 0.7289 GB / 1.826 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.452e-05/6.659, allocations: 43.81 kB / 3.303 GB, free: 0.7288 GB / 1.826 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01916/6.678, allocations: 11.95 MB / 3.315 GB, free: 0.7166 GB / 1.826 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008865/6.687, allocations: 2.825 MB / 3.318 GB, free: 0.7138 GB / 1.826 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005678/6.693, allocations: 155.6 kB / 3.318 GB, free: 0.7136 GB / 1.826 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01451/6.707, allocations: 0.6149 MB / 3.318 GB, free: 0.713 GB / 1.826 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00122/6.708, allocations: 398.6 kB / 3.319 GB, free: 0.7127 GB / 1.826 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001162/6.71, allocations: 263.8 kB / 3.319 GB, free: 0.7124 GB / 1.826 GB
Notification: Performance of sorting global known variables: time 0.02478/6.734, allocations: 11.69 MB / 3.331 GB, free: 0.7011 GB / 1.826 GB
Notification: Performance of sort global known variables: time 1.113e-06/6.735, allocations: 0 / 3.331 GB, free: 0.7011 GB / 1.826 GB
Notification: Performance of remove unused functions: time 0.0236/6.758, allocations: 5.295 MB / 3.336 GB, free: 0.6962 GB / 1.826 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.01265/6.771, allocations: 4.336 MB / 3.34 GB, free: 0.6924 GB / 1.826 GB
Notification: Performance of simCode: created initialization part: time 0.01081/6.782, allocations: 5.848 MB / 3.346 GB, free: 0.6867 GB / 1.826 GB
Notification: Performance of simCode: created event and clocks part: time 4.002e-05/6.782, allocations: 10.25 kB / 3.346 GB, free: 0.6867 GB / 1.826 GB
Notification: Performance of simCode: created simulation system equations: time 0.003866/6.786, allocations: 2.585 MB / 3.348 GB, free: 0.6842 GB / 1.826 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05246/6.838, allocations: 10.07 MB / 3.358 GB, free: 0.6751 GB / 1.826 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.04793/6.886, allocations: 34.06 MB / 3.391 GB, free: 0.6414 GB / 1.826 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01091/6.897, allocations: 7.779 MB / 3.399 GB, free: 0.6338 GB / 1.826 GB
Notification: Performance of simCode: alias equations: time 0.01786/6.915, allocations: 3.213 MB / 3.402 GB, free: 0.6307 GB / 1.826 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003556/6.919, allocations: 1.07 MB / 3.403 GB, free: 0.6297 GB / 1.826 GB
Notification: Performance of SimCode: time 1.463e-06/6.919, allocations: 0 / 3.403 GB, free: 0.6297 GB / 1.826 GB
Notification: Performance of Templates: time 0.4514/7.37, allocations: 350.9 MB / 3.746 GB, free: 296.4 MB / 1.826 GB
make -j1 -f Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.makefile
(rm -f Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & ./Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1)
diffSimulationResults("Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches