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.009759/0.009758, allocations: 104.7 kB / 15.74 MB, free: 6.484 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.001802/0.001803, allocations: 193.5 kB / 16.67 MB, free: 6.375 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.433/1.433, allocations: 222.9 MB / 240.4 MB, free: 4.305 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.858/2.858, allocations: 461.9 MB / 0.7348 GB, free: 14.62 MB / 0.5919 GB
Notification: Performance of FrontEnd - loaded program: time 0.001377/0.001377, allocations: 63.91 kB / 1.054 GB, free: 7.09 MB / 0.8106 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.339/0.3404, allocations: 157.4 MB / 1.208 GB, free: 9.586 MB / 0.9669 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 4.406/4.746, allocations: 1.369 GB / 2.577 GB, free: 92.33 MB / 1.732 GB
Notification: Performance of NFInst.instExpressions: time 0.4332/5.179, allocations: 333.9 MB / 2.903 GB, free: 34.58 MB / 1.732 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.08042/5.26, allocations: 1.224 MB / 2.904 GB, free: 33.82 MB / 1.732 GB
Notification: Performance of NFTyping.typeComponents: time 0.04882/5.309, allocations: 13.5 MB / 2.918 GB, free: 21.94 MB / 1.732 GB
Notification: Performance of NFTyping.typeBindings: time 0.1335/5.442, allocations: 33.91 MB / 2.951 GB, free: 8.559 MB / 1.748 GB
Notification: Performance of NFTyping.typeClassSections: time 0.06824/5.511, allocations: 19.84 MB / 2.97 GB, free: 6.777 MB / 1.764 GB
Notification: Performance of NFFlatten.flatten: time 0.1022/5.613, allocations: 58.31 MB / 3.027 GB, free: 14.02 MB / 1.826 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.06189/5.675, allocations: 23.36 MB / 3.05 GB, free: 6.762 MB / 1.842 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.08512/5.76, allocations: 25.68 MB / 3.075 GB, free: 14.54 MB / 1.873 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.06452/5.824, allocations: 17.74 MB / 3.092 GB, free: 13.95 MB / 1.889 GB
Notification: Performance of NFPackage.collectConstants: time 0.01557/5.84, allocations: 2.129 MB / 3.094 GB, free: 11.82 MB / 1.889 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.1028/5.943, allocations: 17.98 MB / 3.112 GB, free: 10.55 MB / 1.904 GB
Notification: Performance of NFScalarize.scalarize: time 0.02075/5.964, allocations: 4.886 MB / 3.117 GB, free: 5.723 MB / 1.904 GB
Notification: Performance of NFVerifyModel.verify: time 0.04505/6.009, allocations: 11.17 MB / 3.128 GB, free: 10.58 MB / 1.92 GB
Notification: Performance of NFConvertDAE.convert: time 0.106/6.115, allocations: 40.96 MB / 3.168 GB, free: 2.914 MB / 1.951 GB
Notification: Performance of FrontEnd - DAE generated: time 7.494e-06/6.115, allocations: 8 kB / 3.168 GB, free: 2.906 MB / 1.951 GB
Notification: Performance of FrontEnd: time 2.204e-06/6.115, allocations: 0 / 3.168 GB, free: 2.906 MB / 1.951 GB
Notification: Performance of Transformations before backend: time 0.001447/6.117, allocations: 0 / 3.168 GB, free: 2.906 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.0594/6.176, allocations: 20.92 MB / 3.188 GB, free: 14.09 MB / 1.982 GB
Notification: Performance of prepare preOptimizeDAE: time 5.896e-05/6.176, allocations: 8.625 kB / 3.188 GB, free: 14.08 MB / 1.982 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01099/6.187, allocations: 2.252 MB / 3.19 GB, free: 11.8 MB / 1.982 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04418/6.231, allocations: 18.89 MB / 3.209 GB, free: 9.203 MB / 1.998 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001211/6.232, allocations: 0.9717 MB / 3.21 GB, free: 8.23 MB / 1.998 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004765/6.237, allocations: 1.3 MB / 3.211 GB, free: 6.934 MB / 1.998 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04395/6.281, allocations: 14.61 MB / 3.225 GB, free: 7.574 MB / 2.014 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006969/6.282, allocations: 51.55 kB / 3.225 GB, free: 7.523 MB / 2.014 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003926/6.286, allocations: 0.5338 MB / 3.226 GB, free: 6.992 MB / 2.014 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000418/6.286, allocations: 348 kB / 3.226 GB, free: 6.652 MB / 2.014 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02316/6.31, allocations: 10.09 MB / 3.236 GB, free: 12.57 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 1.636/7.946, allocations: 76.46 MB / 3.311 GB, free: 0.9427 GB / 2.029 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.009006/7.955, allocations: 4.567 MB / 3.315 GB, free: 0.9405 GB / 2.029 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004805/7.959, allocations: 2.433 MB / 3.317 GB, free: 0.9395 GB / 2.029 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.08855/8.048, allocations: 51.67 MB / 3.368 GB, free: 0.9021 GB / 2.029 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002907/8.048, allocations: 119 kB / 3.368 GB, free: 0.902 GB / 2.029 GB
Notification: Performance of pre-optimization done (n=412): time 3.344e-05/8.048, allocations: 0 / 3.368 GB, free: 0.902 GB / 2.029 GB
Notification: Performance of matching and sorting (n=412): time 0.02339/8.072, allocations: 6.997 MB / 3.375 GB, free: 0.8991 GB / 2.029 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0003348/8.072, allocations: 0.7995 MB / 3.376 GB, free: 0.8982 GB / 2.029 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.05051/8.123, allocations: 16.67 MB / 3.392 GB, free: 0.8899 GB / 2.029 GB
Notification: Performance of collectPreVariables (initialization): time 0.001811/8.125, allocations: 147 kB / 3.392 GB, free: 0.8898 GB / 2.029 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01033/8.135, allocations: 8.566 MB / 3.4 GB, free: 0.8826 GB / 2.029 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002679/8.138, allocations: 1.467 MB / 3.402 GB, free: 0.8814 GB / 2.029 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003032/8.141, allocations: 1.489 MB / 3.403 GB, free: 0.8805 GB / 2.029 GB
Notification: Performance of setup shared object (initialization): time 5.242e-05/8.141, allocations: 306.9 kB / 3.404 GB, free: 0.8802 GB / 2.029 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003147/8.144, allocations: 2.082 MB / 3.406 GB, free: 0.8792 GB / 2.029 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005648/8.15, allocations: 5.276 MB / 3.411 GB, free: 0.8743 GB / 2.029 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008394/8.158, allocations: 7.144 MB / 3.418 GB, free: 0.8688 GB / 2.029 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.183e-05/8.158, allocations: 23.72 kB / 3.418 GB, free: 0.8688 GB / 2.029 GB
Notification: Performance of matching and sorting (n=847) (initialization): time 0.02102/8.179, allocations: 8.362 MB / 3.426 GB, free: 0.8647 GB / 2.029 GB
Notification: Performance of prepare postOptimizeDAE: time 7.711e-05/8.179, allocations: 39.41 kB / 3.426 GB, free: 0.8647 GB / 2.029 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000102/8.179, allocations: 82.66 kB / 3.426 GB, free: 0.8647 GB / 2.029 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001442/8.18, allocations: 118.4 kB / 3.426 GB, free: 0.8647 GB / 2.029 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004869/8.184, allocations: 1.459 MB / 3.428 GB, free: 0.8644 GB / 2.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001722/8.185, allocations: 169.5 kB / 3.428 GB, free: 0.8643 GB / 2.029 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0138/8.198, allocations: 1.317 MB / 3.429 GB, free: 0.8635 GB / 2.029 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001527/8.2, allocations: 388.3 kB / 3.429 GB, free: 0.8634 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.01045/8.21, allocations: 3.574 MB / 3.433 GB, free: 0.8612 GB / 2.029 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006474/8.217, allocations: 1.664 MB / 3.435 GB, free: 0.8603 GB / 2.029 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01483/8.232, allocations: 7.545 MB / 3.442 GB, free: 0.8563 GB / 2.029 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001297/8.232, allocations: 76.95 kB / 3.442 GB, free: 0.8563 GB / 2.029 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.715e-05/8.232, allocations: 8.438 kB / 3.442 GB, free: 0.8563 GB / 2.029 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003927/8.236, allocations: 3.845 MB / 3.446 GB, free: 0.8534 GB / 2.029 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.05093/8.287, allocations: 28.78 MB / 3.474 GB, free: 0.8337 GB / 2.029 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.961e-05/8.287, allocations: 32 kB / 3.474 GB, free: 0.8336 GB / 2.029 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002772/8.29, allocations: 0.7762 MB / 3.475 GB, free: 0.8329 GB / 2.029 GB
Notification: Performance of postOpt tearingSystem (simulation): time 4.436e-05/8.29, allocations: 56 kB / 3.475 GB, free: 0.8328 GB / 2.029 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003432/8.29, allocations: 152 kB / 3.475 GB, free: 0.8327 GB / 2.029 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 3.957e-05/8.29, allocations: 79.66 kB / 3.475 GB, free: 0.8326 GB / 2.029 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.898e-05/8.29, allocations: 43.81 kB / 3.475 GB, free: 0.8326 GB / 2.029 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01549/8.306, allocations: 11.96 MB / 3.487 GB, free: 0.8203 GB / 2.029 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008651/8.314, allocations: 2.844 MB / 3.489 GB, free: 0.8175 GB / 2.029 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004894/8.319, allocations: 163.5 kB / 3.49 GB, free: 0.8174 GB / 2.029 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009474/8.329, allocations: 251.2 kB / 3.49 GB, free: 0.8171 GB / 2.029 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008214/8.33, allocations: 405.4 kB / 3.49 GB, free: 0.8167 GB / 2.029 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006588/8.33, allocations: 255.9 kB / 3.49 GB, free: 0.8165 GB / 2.029 GB
Notification: Performance of sorting global known variables: time 0.02189/8.352, allocations: 11.85 MB / 3.502 GB, free: 0.805 GB / 2.029 GB
Notification: Performance of sort global known variables: time 3.71e-07/8.352, allocations: 0 / 3.502 GB, free: 0.805 GB / 2.029 GB
Notification: Performance of remove unused functions: time 0.01996/8.372, allocations: 5.359 MB / 3.507 GB, free: 0.8 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.01198/8.384, allocations: 4.423 MB / 3.512 GB, free: 0.7963 GB / 2.029 GB
Notification: Performance of simCode: created initialization part: time 0.01098/8.395, allocations: 5.668 MB / 3.517 GB, free: 0.7908 GB / 2.029 GB
Notification: Performance of simCode: created event and clocks part: time 6.012e-05/8.395, allocations: 8 kB / 3.517 GB, free: 0.7908 GB / 2.029 GB
Notification: Performance of simCode: created simulation system equations: time 0.004211/8.4, allocations: 2.58 MB / 3.52 GB, free: 0.7883 GB / 2.029 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04977/8.449, allocations: 10.01 MB / 3.529 GB, free: 0.7792 GB / 2.029 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.0471/8.497, allocations: 28.29 MB / 3.557 GB, free: 0.7512 GB / 2.029 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01195/8.509, allocations: 7.779 MB / 3.565 GB, free: 0.7436 GB / 2.029 GB
Notification: Performance of simCode: alias equations: time 0.0165/8.525, allocations: 3.244 MB / 3.568 GB, free: 0.7406 GB / 2.029 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003889/8.529, allocations: 1.073 MB / 3.569 GB, free: 0.7395 GB / 2.029 GB
Notification: Performance of SimCode: time 1.382e-06/8.529, allocations: 4 kB / 3.569 GB, free: 0.7395 GB / 2.029 GB
Notification: Performance of Templates: time 0.4646/8.994, allocations: 354.4 MB / 3.915 GB, free: 404.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