Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_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.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-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.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.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_latest_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.008682/0.008682, allocations: 101.8 kB / 15.73 MB, free: 6.043 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.002013/0.002013, allocations: 184.9 kB / 16.67 MB, free: 5.977 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.447/1.447, allocations: 222.9 MB / 240.4 MB, free: 4.316 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.789/2.789, allocations: 461.9 MB / 0.7347 GB, free: 14.7 MB / 0.5919 GB
Notification: Performance of FrontEnd - loaded program: time 0.001443/0.001443, allocations: 71.89 kB / 1.054 GB, free: 7.164 MB / 0.8106 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.332/0.3334, allocations: 157.4 MB / 1.208 GB, free: 9.66 MB / 0.9669 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 4.351/4.684, allocations: 1.369 GB / 2.577 GB, free: 92.45 MB / 1.732 GB
Notification: Performance of NFInst.instExpressions: time 0.3926/5.077, allocations: 333.9 MB / 2.903 GB, free: 34.41 MB / 1.732 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.07045/5.147, allocations: 1.224 MB / 2.904 GB, free: 33.64 MB / 1.732 GB
Notification: Performance of NFTyping.typeComponents: time 0.04391/5.191, allocations: 13.51 MB / 2.918 GB, free: 21.74 MB / 1.732 GB
Notification: Performance of NFTyping.typeBindings: time 0.1215/5.313, allocations: 33.91 MB / 2.951 GB, free: 8.363 MB / 1.748 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06171/5.375, allocations: 19.84 MB / 2.97 GB, free: 6.578 MB / 1.764 GB
Notification: Performance of NFFlatten.flatten: time 0.09521/5.47, allocations: 58.32 MB / 3.027 GB, free: 13.81 MB / 1.826 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.05167/5.522, allocations: 23.37 MB / 3.05 GB, free: 6.551 MB / 1.842 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.07356/5.595, allocations: 25.66 MB / 3.075 GB, free: 14.34 MB / 1.873 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.04292/5.638, allocations: 17.76 MB / 3.092 GB, free: 13.74 MB / 1.889 GB
Notification: Performance of NFPackage.collectConstants: time 0.01264/5.651, allocations: 2.129 MB / 3.094 GB, free: 11.61 MB / 1.889 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.05811/5.709, allocations: 17.98 MB / 3.112 GB, free: 10.34 MB / 1.904 GB
Notification: Performance of NFScalarize.scalarize: time 0.01267/5.722, allocations: 4.884 MB / 3.117 GB, free: 5.508 MB / 1.904 GB
Notification: Performance of NFVerifyModel.verify: time 0.03363/5.755, allocations: 11.17 MB / 3.128 GB, free: 10.37 MB / 1.92 GB
Notification: Performance of NFConvertDAE.convert: time 0.1044/5.86, allocations: 40.96 MB / 3.168 GB, free: 2.695 MB / 1.951 GB
Notification: Performance of FrontEnd - DAE generated: time 8.496e-06/5.86, allocations: 3.938 kB / 3.168 GB, free: 2.691 MB / 1.951 GB
Notification: Performance of FrontEnd: time 1.883e-06/5.86, allocations: 4 kB / 3.168 GB, free: 2.688 MB / 1.951 GB
Notification: Performance of Transformations before backend: time 0.001382/5.861, allocations: 0 / 3.168 GB, free: 2.688 MB / 1.951 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.07548/5.937, allocations: 20.91 MB / 3.188 GB, free: 13.85 MB / 1.982 GB
Notification: Performance of prepare preOptimizeDAE: time 5.725e-05/5.937, allocations: 8.625 kB / 3.188 GB, free: 13.84 MB / 1.982 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01231/5.949, allocations: 2.252 MB / 3.19 GB, free: 11.56 MB / 1.982 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04615/5.995, allocations: 18.89 MB / 3.209 GB, free: 8.957 MB / 1.998 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001279/5.997, allocations: 0.9773 MB / 3.21 GB, free: 7.98 MB / 1.998 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005149/6.002, allocations: 1.292 MB / 3.211 GB, free: 6.691 MB / 1.998 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0469/6.049, allocations: 14.61 MB / 3.225 GB, free: 7.336 MB / 2.014 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0007056/6.05, allocations: 47.56 kB / 3.225 GB, free: 7.289 MB / 2.014 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00425/6.054, allocations: 0.5339 MB / 3.226 GB, free: 6.758 MB / 2.014 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004366/6.054, allocations: 340 kB / 3.226 GB, free: 6.426 MB / 2.014 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02314/6.078, allocations: 10.1 MB / 3.236 GB, free: 12.33 MB / 2.029 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.9721/7.05, allocations: 76.46 MB / 3.311 GB, free: 0.9459 GB / 2.029 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00891/7.059, allocations: 4.563 MB / 3.315 GB, free: 0.9438 GB / 2.029 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004739/7.063, allocations: 2.442 MB / 3.317 GB, free: 0.9427 GB / 2.029 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.08745/7.151, allocations: 51.66 MB / 3.368 GB, free: 0.9054 GB / 2.029 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002453/7.151, allocations: 125.1 kB / 3.368 GB, free: 0.9053 GB / 2.029 GB
Notification: Performance of pre-optimization done (n=412): time 8.116e-06/7.151, allocations: 0 / 3.368 GB, free: 0.9053 GB / 2.029 GB
Notification: Performance of matching and sorting (n=412): time 0.02151/7.173, allocations: 6.997 MB / 3.375 GB, free: 0.9024 GB / 2.029 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002557/7.173, allocations: 0.802 MB / 3.376 GB, free: 0.9015 GB / 2.029 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.04246/7.216, allocations: 16.67 MB / 3.392 GB, free: 0.8932 GB / 2.029 GB
Notification: Performance of collectPreVariables (initialization): time 0.001423/7.217, allocations: 136.9 kB / 3.392 GB, free: 0.8931 GB / 2.029 GB
Notification: Performance of collectInitialEqns (initialization): time 0.009934/7.227, allocations: 8.579 MB / 3.4 GB, free: 0.8859 GB / 2.029 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002505/7.229, allocations: 1.47 MB / 3.402 GB, free: 0.8847 GB / 2.029 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003656/7.233, allocations: 1.483 MB / 3.403 GB, free: 0.8839 GB / 2.029 GB
Notification: Performance of setup shared object (initialization): time 6.521e-05/7.233, allocations: 301.1 kB / 3.404 GB, free: 0.8836 GB / 2.029 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003237/7.237, allocations: 2.085 MB / 3.406 GB, free: 0.8825 GB / 2.029 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006097/7.243, allocations: 5.276 MB / 3.411 GB, free: 0.8776 GB / 2.029 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008961/7.252, allocations: 7.14 MB / 3.418 GB, free: 0.8721 GB / 2.029 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001067/7.252, allocations: 27.5 kB / 3.418 GB, free: 0.8721 GB / 2.029 GB
Notification: Performance of matching and sorting (n=847) (initialization): time 0.02038/7.272, allocations: 8.36 MB / 3.426 GB, free: 0.868 GB / 2.029 GB
Notification: Performance of prepare postOptimizeDAE: time 7.399e-05/7.272, allocations: 43.47 kB / 3.426 GB, free: 0.868 GB / 2.029 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000115/7.272, allocations: 78.97 kB / 3.426 GB, free: 0.868 GB / 2.029 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001435/7.273, allocations: 118.7 kB / 3.426 GB, free: 0.868 GB / 2.029 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005118/7.278, allocations: 1.455 MB / 3.428 GB, free: 0.8677 GB / 2.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001449/7.278, allocations: 169.6 kB / 3.428 GB, free: 0.8677 GB / 2.029 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0143/7.292, allocations: 1.322 MB / 3.429 GB, free: 0.8668 GB / 2.029 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001954/7.294, allocations: 392.8 kB / 3.429 GB, free: 0.8667 GB / 2.029 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 367
 * 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 (847):
 * Single equations (assignments): 847
 * 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.01125/7.305, allocations: 3.575 MB / 3.433 GB, free: 0.8645 GB / 2.029 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00638/7.312, allocations: 1.661 MB / 3.434 GB, free: 0.8636 GB / 2.029 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01574/7.328, allocations: 7.535 MB / 3.442 GB, free: 0.8597 GB / 2.029 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001653/7.328, allocations: 83.75 kB / 3.442 GB, free: 0.8596 GB / 2.029 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.668e-05/7.328, allocations: 12.12 kB / 3.442 GB, free: 0.8596 GB / 2.029 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004247/7.332, allocations: 3.847 MB / 3.446 GB, free: 0.8567 GB / 2.029 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.05424/7.386, allocations: 28.78 MB / 3.474 GB, free: 0.8378 GB / 2.029 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.148e-05/7.386, allocations: 32 kB / 3.474 GB, free: 0.8377 GB / 2.029 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002898/7.389, allocations: 0.7774 MB / 3.475 GB, free: 0.837 GB / 2.029 GB
Notification: Performance of postOpt tearingSystem (simulation): time 4.693e-05/7.389, allocations: 52 kB / 3.475 GB, free: 0.8369 GB / 2.029 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000468/7.39, allocations: 155.9 kB / 3.475 GB, free: 0.8368 GB / 2.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 3.81e-05/7.39, allocations: 64.14 kB / 3.475 GB, free: 0.8367 GB / 2.029 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.042e-05/7.39, allocations: 51.81 kB / 3.475 GB, free: 0.8367 GB / 2.029 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0166/7.407, allocations: 11.97 MB / 3.487 GB, free: 0.8244 GB / 2.029 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.009367/7.416, allocations: 2.837 MB / 3.489 GB, free: 0.8216 GB / 2.029 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.007271/7.423, allocations: 159.5 kB / 3.49 GB, free: 0.8214 GB / 2.029 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01177/7.435, allocations: 259 kB / 3.49 GB, free: 0.8212 GB / 2.029 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001191/7.436, allocations: 398.8 kB / 3.49 GB, free: 0.8208 GB / 2.029 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000713/7.437, allocations: 259.8 kB / 3.49 GB, free: 0.8206 GB / 2.029 GB
Notification: Performance of sorting global known variables: time 0.02822/7.465, allocations: 11.86 MB / 3.502 GB, free: 0.8091 GB / 2.029 GB
Notification: Performance of sort global known variables: time 5.81e-07/7.465, allocations: 0 / 3.502 GB, free: 0.8091 GB / 2.029 GB
Notification: Performance of remove unused functions: time 0.02222/7.488, allocations: 5.355 MB / 3.507 GB, free: 0.8041 GB / 2.029 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.01169/7.499, allocations: 4.42 MB / 3.512 GB, free: 0.8003 GB / 2.029 GB
Notification: Performance of simCode: created initialization part: time 0.01069/7.51, allocations: 5.671 MB / 3.517 GB, free: 0.7947 GB / 2.029 GB
Notification: Performance of simCode: created event and clocks part: time 6.13e-05/7.51, allocations: 8 kB / 3.517 GB, free: 0.7947 GB / 2.029 GB
Notification: Performance of simCode: created simulation system equations: time 0.004209/7.514, allocations: 2.585 MB / 3.52 GB, free: 0.7922 GB / 2.029 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05403/7.568, allocations: 10.01 MB / 3.529 GB, free: 0.7831 GB / 2.029 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05364/7.622, allocations: 28.28 MB / 3.557 GB, free: 0.7551 GB / 2.029 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01242/7.634, allocations: 7.779 MB / 3.565 GB, free: 0.7474 GB / 2.029 GB
Notification: Performance of simCode: alias equations: time 0.01515/7.65, allocations: 3.247 MB / 3.568 GB, free: 0.7444 GB / 2.029 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003465/7.653, allocations: 1.073 MB / 3.569 GB, free: 0.7434 GB / 2.029 GB
Notification: Performance of SimCode: time 8.02e-07/7.653, allocations: 0 / 3.569 GB, free: 0.7434 GB / 2.029 GB
Notification: Performance of Templates: time 0.4344/8.088, allocations: 354.4 MB / 3.915 GB, free: 408.6 MB / 2.029 GB
make -j1 -f Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.makefile
(rm -f Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & ./Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches