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.00155/0.00155, allocations: 111.3 kB / 15.23 MB, free: 0.6602 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.001728/0.001728, allocations: 195.7 kB / 16.14 MB, free: 6.652 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.463/1.463, allocations: 222.9 MB / 239.8 MB, free: 4.578 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.9/2.9, allocations: 461.9 MB / 0.7342 GB, free: 15 MB / 0.5919 GB
Notification: Performance of FrontEnd - loaded program: time 0.001292/0.001292, allocations: 64.98 kB / 0.8984 GB, free: 37.28 MB / 0.7169 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3719/0.3732, allocations: 157.4 MB / 1.052 GB, free: 8.832 MB / 0.8106 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 4.115/4.488, allocations: 1.36 GB / 2.412 GB, free: 82.76 MB / 1.561 GB
Notification: Performance of NFInst.instExpressions: time 0.3938/4.882, allocations: 334.5 MB / 2.739 GB, free: 29.54 MB / 1.561 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.06061/4.943, allocations: 1.122 MB / 2.74 GB, free: 28.84 MB / 1.561 GB
Notification: Performance of NFTyping.typeComponents: time 0.04215/4.985, allocations: 10.88 MB / 2.75 GB, free: 18.38 MB / 1.561 GB
Notification: Performance of NFTyping.typeBindings: time 0.09884/5.084, allocations: 29.43 MB / 2.779 GB, free: 9.504 MB / 1.576 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05333/5.137, allocations: 18.07 MB / 2.797 GB, free: 9.43 MB / 1.592 GB
Notification: Performance of NFFlatten.flatten: time 0.1023/5.239, allocations: 75.89 MB / 2.871 GB, free: 15.05 MB / 1.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04447/5.284, allocations: 18.98 MB / 2.889 GB, free: 12.19 MB / 1.686 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.06198/5.346, allocations: 20.95 MB / 2.91 GB, free: 8.254 MB / 1.701 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03746/5.383, allocations: 17.7 MB / 2.927 GB, free: 7.699 MB / 1.717 GB
Notification: Performance of NFPackage.collectConstants: time 0.007796/5.391, allocations: 0.9062 MB / 2.928 GB, free: 6.793 MB / 1.717 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.05705/5.448, allocations: 15.85 MB / 2.943 GB, free: 7.66 MB / 1.732 GB
Notification: Performance of NFScalarize.scalarize: time 0.009704/5.458, allocations: 3.686 MB / 2.947 GB, free: 4.027 MB / 1.732 GB
Notification: Performance of NFVerifyModel.verify: time 0.0292/5.487, allocations: 9.861 MB / 2.957 GB, free: 10.19 MB / 1.748 GB
Notification: Performance of NFConvertDAE.convert: time 0.08494/5.572, allocations: 39.86 MB / 2.996 GB, free: 3.641 MB / 1.779 GB
Notification: Performance of FrontEnd - DAE generated: time 6.833e-06/5.572, allocations: 4 kB / 2.996 GB, free: 3.637 MB / 1.779 GB
Notification: Performance of FrontEnd: time 2.806e-06/5.572, allocations: 0 / 2.996 GB, free: 3.637 MB / 1.779 GB
Notification: Performance of Transformations before backend: time 0.001428/5.574, allocations: 0 / 2.996 GB, free: 3.637 MB / 1.779 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.06285/5.637, allocations: 20.91 MB / 3.016 GB, free: 14.79 MB / 1.811 GB
Notification: Performance of prepare preOptimizeDAE: time 5.425e-05/5.637, allocations: 8.031 kB / 3.016 GB, free: 14.79 MB / 1.811 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01151/5.648, allocations: 2.259 MB / 3.018 GB, free: 12.5 MB / 1.811 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04402/5.692, allocations: 18.03 MB / 3.036 GB, free: 10.79 MB / 1.826 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001205/5.694, allocations: 0.9739 MB / 3.037 GB, free: 9.809 MB / 1.826 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004655/5.698, allocations: 1.285 MB / 3.038 GB, free: 8.527 MB / 1.826 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.8263/6.524, allocations: 14.49 MB / 3.052 GB, free: 0.9376 GB / 1.826 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000567/6.525, allocations: 36.11 kB / 3.052 GB, free: 0.9376 GB / 1.826 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002957/6.528, allocations: 0.5307 MB / 3.053 GB, free: 0.9376 GB / 1.826 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003091/6.528, allocations: 350.2 kB / 3.053 GB, free: 0.9376 GB / 1.826 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02423/6.553, allocations: 10.09 MB / 3.063 GB, free: 0.9373 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.0978/6.65, allocations: 74.72 MB / 3.136 GB, free: 0.8817 GB / 1.826 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.006733/6.657, allocations: 4.571 MB / 3.14 GB, free: 0.8791 GB / 1.826 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002931/6.66, allocations: 2.438 MB / 3.143 GB, free: 0.8777 GB / 1.826 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.07137/6.732, allocations: 51.5 MB / 3.193 GB, free: 0.8346 GB / 1.826 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002124/6.732, allocations: 114.8 kB / 3.193 GB, free: 0.8345 GB / 1.826 GB
Notification: Performance of pre-optimization done (n=412): time 1.787e-05/6.732, allocations: 0 / 3.193 GB, free: 0.8345 GB / 1.826 GB
Notification: Performance of matching and sorting (n=412): time 0.01766/6.75, allocations: 6.99 MB / 3.2 GB, free: 0.8311 GB / 1.826 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002028/6.75, allocations: 0.7906 MB / 3.201 GB, free: 0.8302 GB / 1.826 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.038/6.788, allocations: 16.43 MB / 3.217 GB, free: 0.822 GB / 1.826 GB
Notification: Performance of collectPreVariables (initialization): time 0.001411/6.789, allocations: 141 kB / 3.217 GB, free: 0.8219 GB / 1.826 GB
Notification: Performance of collectInitialEqns (initialization): time 0.008696/6.798, allocations: 8.656 MB / 3.225 GB, free: 0.8144 GB / 1.826 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002238/6.8, allocations: 1.46 MB / 3.227 GB, free: 0.8132 GB / 1.826 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.002597/6.803, allocations: 1.451 MB / 3.228 GB, free: 0.8124 GB / 1.826 GB
Notification: Performance of setup shared object (initialization): time 5.822e-05/6.803, allocations: 301.1 kB / 3.228 GB, free: 0.8121 GB / 1.826 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002938/6.806, allocations: 2.043 MB / 3.23 GB, free: 0.8111 GB / 1.826 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005103/6.811, allocations: 5.089 MB / 3.235 GB, free: 0.8064 GB / 1.826 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007499/6.818, allocations: 6.882 MB / 3.242 GB, free: 0.8007 GB / 1.826 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.949e-05/6.819, allocations: 23.94 kB / 3.242 GB, free: 0.8007 GB / 1.826 GB
Notification: Performance of matching and sorting (n=821) (initialization): time 0.01708/6.836, allocations: 8.145 MB / 3.25 GB, free: 0.7928 GB / 1.826 GB
Notification: Performance of prepare postOptimizeDAE: time 5.822e-05/6.836, allocations: 36 kB / 3.25 GB, free: 0.7928 GB / 1.826 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.363e-05/6.836, allocations: 76 kB / 3.25 GB, free: 0.7927 GB / 1.826 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001021/6.836, allocations: 112 kB / 3.25 GB, free: 0.7926 GB / 1.826 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004418/6.84, allocations: 1.408 MB / 3.252 GB, free: 0.7912 GB / 1.826 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001181/6.841, allocations: 155.4 kB / 3.252 GB, free: 0.7911 GB / 1.826 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01531/6.856, allocations: 1.863 MB / 3.254 GB, free: 0.7893 GB / 1.826 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001505/6.857, allocations: 383.9 kB / 3.254 GB, free: 0.7889 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.008797/6.866, allocations: 3.556 MB / 3.258 GB, free: 0.7854 GB / 1.826 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005362/6.872, allocations: 1.651 MB / 3.259 GB, free: 0.7838 GB / 1.826 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01425/6.886, allocations: 7.561 MB / 3.267 GB, free: 0.7765 GB / 1.826 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001737/6.886, allocations: 83.94 kB / 3.267 GB, free: 0.7764 GB / 1.826 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.651e-05/6.886, allocations: 11.94 kB / 3.267 GB, free: 0.7764 GB / 1.826 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003871/6.89, allocations: 3.829 MB / 3.27 GB, free: 0.7724 GB / 1.826 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04968/6.94, allocations: 28.68 MB / 3.298 GB, free: 0.744 GB / 1.826 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001304/6.94, allocations: 35.75 kB / 3.298 GB, free: 0.744 GB / 1.826 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002856/6.943, allocations: 0.773 MB / 3.299 GB, free: 0.7432 GB / 1.826 GB
Notification: Performance of postOpt tearingSystem (simulation): time 6.381e-05/6.943, allocations: 56 kB / 3.299 GB, free: 0.7432 GB / 1.826 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0006906/6.943, allocations: 159.8 kB / 3.299 GB, free: 0.743 GB / 1.826 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.602e-05/6.944, allocations: 67.78 kB / 3.299 GB, free: 0.7429 GB / 1.826 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.974e-05/6.944, allocations: 51.75 kB / 3.299 GB, free: 0.7429 GB / 1.826 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01764/6.961, allocations: 11.95 MB / 3.311 GB, free: 0.7306 GB / 1.826 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008782/6.97, allocations: 2.825 MB / 3.314 GB, free: 0.7278 GB / 1.826 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006093/6.976, allocations: 155.6 kB / 3.314 GB, free: 0.7277 GB / 1.826 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0116/6.988, allocations: 0.6071 MB / 3.315 GB, free: 0.7271 GB / 1.826 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001098/6.989, allocations: 402.7 kB / 3.315 GB, free: 0.7267 GB / 1.826 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001082/6.99, allocations: 259.8 kB / 3.315 GB, free: 0.7265 GB / 1.826 GB
Notification: Performance of sorting global known variables: time 0.02847/7.018, allocations: 11.7 MB / 3.327 GB, free: 0.7152 GB / 1.826 GB
Notification: Performance of sort global known variables: time 6.51e-07/7.018, allocations: 0 / 3.327 GB, free: 0.7152 GB / 1.826 GB
Notification: Performance of remove unused functions: time 0.02152/7.04, allocations: 5.292 MB / 3.332 GB, free: 0.7102 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.0129/7.053, allocations: 4.325 MB / 3.336 GB, free: 0.7065 GB / 1.826 GB
Notification: Performance of simCode: created initialization part: time 0.01077/7.064, allocations: 5.509 MB / 3.341 GB, free: 0.7011 GB / 1.826 GB
Notification: Performance of simCode: created event and clocks part: time 4.074e-05/7.064, allocations: 10.25 kB / 3.341 GB, free: 0.7011 GB / 1.826 GB
Notification: Performance of simCode: created simulation system equations: time 0.004406/7.068, allocations: 2.589 MB / 3.344 GB, free: 0.6986 GB / 1.826 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.05536/7.124, allocations: 9.626 MB / 3.353 GB, free: 0.6897 GB / 1.826 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0556/7.179, allocations: 34.07 MB / 3.387 GB, free: 0.656 GB / 1.826 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01379/7.193, allocations: 7.779 MB / 3.394 GB, free: 0.6484 GB / 1.826 GB
Notification: Performance of simCode: alias equations: time 0.01868/7.212, allocations: 3.206 MB / 3.397 GB, free: 0.6455 GB / 1.826 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004336/7.216, allocations: 1.073 MB / 3.398 GB, free: 0.6444 GB / 1.826 GB
Notification: Performance of SimCode: time 1.452e-06/7.216, allocations: 0 / 3.398 GB, free: 0.6444 GB / 1.826 GB
Notification: Performance of Templates: time 0.4471/7.663, allocations: 342.3 MB / 3.733 GB, free: 319.9 MB / 1.826 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