Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_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 9.1.3-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.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: "" <> buildModelFMU(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS,fileNamePrefix="Buildings_9_Buildings_Experimental_DHC_Loads_BaseClasses_Validation_BuildingWithETS",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS,fileNamePrefix="Buildings_9_Buildings_Experimental_DHC_Loads_BaseClasses_Validation_BuildingWithETS",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00495/0.00495, 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.001224/0.001224, 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.272/1.272, allocations: 222.9 MB / 240.4 MB, free: 4.324 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo): time 2.217/2.217, allocations: 390.2 MB / 0.6648 GB, free: 204 kB / 0.5137 GB
Notification: Performance of FrontEnd - loaded program: time 0.001131/0.001131, allocations: 66.73 kB / 0.9504 GB, free: 5.859 MB / 0.7169 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2598/0.261, allocations: 140.4 MB / 1.087 GB, free: 1.984 MB / 0.8419 GB
Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 3.446/3.707, allocations: 1.349 GB / 2.436 GB, free: 96.11 MB / 1.623 GB
Notification: Performance of NFInst.instExpressions: time 0.3349/4.042, allocations: 330.5 MB / 2.759 GB, free: 58.27 MB / 1.623 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.04912/4.092, allocations: 1.162 MB / 2.76 GB, free: 58.27 MB / 1.623 GB
Notification: Performance of NFTyping.typeComponents: time 0.03642/4.128, allocations: 12.95 MB / 2.773 GB, free: 50.27 MB / 1.623 GB
Notification: Performance of NFTyping.typeBindings: time 0.08446/4.213, allocations: 32.16 MB / 2.804 GB, free: 22.64 MB / 1.623 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04456/4.257, allocations: 18.88 MB / 2.823 GB, free: 5.512 MB / 1.623 GB
Notification: Performance of NFFlatten.flatten: time 0.07239/4.33, allocations: 56.62 MB / 2.878 GB, free: 14.44 MB / 1.686 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.03795/4.368, allocations: 22.23 MB / 2.9 GB, free: 8.324 MB / 1.701 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.0614/4.429, allocations: 24.78 MB / 2.924 GB, free: 0.9727 MB / 1.717 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03456/4.464, allocations: 17.6 MB / 2.941 GB, free: 0.5547 MB / 1.732 GB
Notification: Performance of NFPackage.collectConstants: time 0.008788/4.473, allocations: 2.055 MB / 2.943 GB, free: 14.5 MB / 1.748 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04591/4.518, allocations: 17.9 MB / 2.96 GB, free: 13.31 MB / 1.764 GB
Notification: Performance of NFScalarize.scalarize: time 0.009225/4.528, allocations: 4.731 MB / 2.965 GB, free: 8.633 MB / 1.764 GB
Notification: Performance of NFVerifyModel.verify: time 0.02568/4.553, allocations: 10.86 MB / 2.976 GB, free: 13.79 MB / 1.779 GB
Notification: Performance of NFConvertDAE.convert: time 0.07374/4.627, allocations: 41.11 MB / 3.016 GB, free: 5.938 MB / 1.811 GB
Notification: Performance of FrontEnd - DAE generated: time 7.694e-06/4.627, allocations: 0 / 3.016 GB, free: 5.938 MB / 1.811 GB
Notification: Performance of FrontEnd: time 1.823e-06/4.627, allocations: 0 / 3.016 GB, free: 5.938 MB / 1.811 GB
Notification: Performance of Transformations before backend: time 0.001056/4.628, allocations: 0 / 3.016 GB, free: 5.938 MB / 1.811 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 3135
 * Number of variables: 3135
Notification: Performance of Generate backend data structure: time 0.04604/4.674, allocations: 20.35 MB / 3.036 GB, free: 1.641 MB / 1.826 GB
Notification: Performance of prepare preOptimizeDAE: time 5.232e-05/4.674, allocations: 12.02 kB / 3.036 GB, free: 1.629 MB / 1.826 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.003545/4.678, allocations: 1.576 MB / 3.037 GB, free: 44 kB / 1.826 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007291/4.685, allocations: 2.179 MB / 3.039 GB, free: 13.84 MB / 1.842 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03368/4.719, allocations: 18.27 MB / 3.057 GB, free: 11.87 MB / 1.857 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007643/4.72, allocations: 0.9512 MB / 3.058 GB, free: 10.92 MB / 1.857 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002986/4.723, allocations: 1.254 MB / 3.059 GB, free: 9.668 MB / 1.857 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02598/4.749, allocations: 14.1 MB / 3.073 GB, free: 10.79 MB / 1.873 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.000252/4.749, allocations: 39.62 kB / 3.073 GB, free: 10.75 MB / 1.873 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001102/4.75, allocations: 0.5116 MB / 3.074 GB, free: 10.24 MB / 1.873 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002498/4.75, allocations: 336 kB / 3.074 GB, free: 9.914 MB / 1.873 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01707/4.768, allocations: 9.688 MB / 3.083 GB, free: 264 kB / 1.873 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.7251/5.493, allocations: 72.17 MB / 3.154 GB, free: 0.9587 GB / 1.92 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.008382/5.501, allocations: 4.563 MB / 3.158 GB, free: 0.958 GB / 1.92 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003482/5.505, allocations: 2.439 MB / 3.161 GB, free: 0.9578 GB / 1.92 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0831/5.588, allocations: 51.67 MB / 3.211 GB, free: 0.9214 GB / 1.92 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.000189/5.588, allocations: 124.8 kB / 3.211 GB, free: 0.9213 GB / 1.92 GB
Notification: Performance of pre-optimization done (n=412): time 2.18e-05/5.588, allocations: 0 / 3.211 GB, free: 0.9213 GB / 1.92 GB
Notification: Performance of matching and sorting (n=412): time 0.01644/5.604, allocations: 6.96 MB / 3.218 GB, free: 0.9201 GB / 1.92 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0002011/5.605, allocations: 0.7927 MB / 3.219 GB, free: 0.9192 GB / 1.92 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0325/5.637, allocations: 16.2 MB / 3.235 GB, free: 0.9135 GB / 1.92 GB
Notification: Performance of collectPreVariables (initialization): time 0.001148/5.638, allocations: 145.1 kB / 3.235 GB, free: 0.9134 GB / 1.92 GB
Notification: Performance of collectInitialEqns (initialization): time 0.008706/5.647, allocations: 8.209 MB / 3.243 GB, free: 0.9069 GB / 1.92 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002119/5.649, allocations: 1.455 MB / 3.244 GB, free: 0.9057 GB / 1.92 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004278/5.654, allocations: 1.416 MB / 3.246 GB, free: 0.9049 GB / 1.92 GB
Notification: Performance of setup shared object (initialization): time 4.561e-05/5.654, allocations: 301.1 kB / 3.246 GB, free: 0.9047 GB / 1.92 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003612/5.657, allocations: 2.012 MB / 3.248 GB, free: 0.9036 GB / 1.92 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005932/5.663, allocations: 4.926 MB / 3.253 GB, free: 0.8992 GB / 1.92 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.007565/5.671, allocations: 6.684 MB / 3.259 GB, free: 0.8942 GB / 1.92 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.969e-05/5.671, allocations: 22.75 kB / 3.259 GB, free: 0.8942 GB / 1.92 GB
Notification: Performance of matching and sorting (n=801) (initialization): time 0.0166/5.688, allocations: 7.959 MB / 3.267 GB, free: 0.8903 GB / 1.92 GB
Notification: Performance of prepare postOptimizeDAE: time 8.54e-05/5.688, allocations: 39.62 kB / 3.267 GB, free: 0.8903 GB / 1.92 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001328/5.688, allocations: 71.03 kB / 3.267 GB, free: 0.8903 GB / 1.92 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000151/5.688, allocations: 102.9 kB / 3.267 GB, free: 0.8903 GB / 1.92 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004097/5.692, allocations: 1.371 MB / 3.269 GB, free: 0.89 GB / 1.92 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001876/5.692, allocations: 153.6 kB / 3.269 GB, free: 0.8899 GB / 1.92 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01179/5.704, allocations: 1.237 MB / 3.27 GB, free: 0.8891 GB / 1.92 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001187/5.705, allocations: 372.6 kB / 3.27 GB, free: 0.889 GB / 1.92 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 321
 * 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 (801):
 * Single equations (assignments): 801
 * 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.008547/5.714, allocations: 3.406 MB / 3.274 GB, free: 0.8869 GB / 1.92 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006364/5.72, allocations: 1.62 MB / 3.275 GB, free: 0.8861 GB / 1.92 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01515/5.735, allocations: 7.51 MB / 3.283 GB, free: 0.8822 GB / 1.92 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.000204/5.736, allocations: 76.05 kB / 3.283 GB, free: 0.8822 GB / 1.92 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.237e-05/5.736, allocations: 9.469 kB / 3.283 GB, free: 0.8822 GB / 1.92 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003813/5.739, allocations: 3.851 MB / 3.286 GB, free: 0.8792 GB / 1.92 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.0474/5.787, allocations: 28.48 MB / 3.314 GB, free: 0.8591 GB / 1.92 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001255/5.787, allocations: 30.91 kB / 3.314 GB, free: 0.8591 GB / 1.92 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002666/5.79, allocations: 0.7723 MB / 3.315 GB, free: 0.8583 GB / 1.92 GB
Notification: Performance of postOpt tearingSystem (simulation): time 8.137e-05/5.79, allocations: 48 kB / 3.315 GB, free: 0.8583 GB / 1.92 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000534/5.79, allocations: 155.9 kB / 3.315 GB, free: 0.8581 GB / 1.92 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 6.318e-05/5.79, allocations: 67.8 kB / 3.315 GB, free: 0.8581 GB / 1.92 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.915e-05/5.79, allocations: 53.97 kB / 3.315 GB, free: 0.858 GB / 1.92 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01525/5.806, allocations: 11.91 MB / 3.327 GB, free: 0.8459 GB / 1.92 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007706/5.813, allocations: 2.825 MB / 3.33 GB, free: 0.8431 GB / 1.92 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004652/5.818, allocations: 151.6 kB / 3.33 GB, free: 0.8429 GB / 1.92 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00912/5.827, allocations: 214.1 kB / 3.33 GB, free: 0.8427 GB / 1.92 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006043/5.828, allocations: 402.4 kB / 3.33 GB, free: 0.8424 GB / 1.92 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000754/5.829, allocations: 261.6 kB / 3.331 GB, free: 0.8421 GB / 1.92 GB
Notification: Performance of sorting global known variables: time 0.02357/5.852, allocations: 11.55 MB / 3.342 GB, free: 0.8309 GB / 1.92 GB
Notification: Performance of sort global known variables: time 3.7e-07/5.852, allocations: 0 / 3.342 GB, free: 0.8309 GB / 1.92 GB
Notification: Performance of remove unused functions: time 0.01987/5.872, allocations: 5.28 MB / 3.347 GB, free: 0.826 GB / 1.92 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 ($cse16.phase,$cse16.region,$cse7.phase,$cse7.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.02744/5.9, allocations: 16.85 MB / 3.364 GB, free: 0.8095 GB / 1.92 GB
Notification: Performance of simCode: created initialization part: time 0.008708/5.908, allocations: 5.499 MB / 3.369 GB, free: 0.8042 GB / 1.92 GB
Notification: Performance of simCode: created event and clocks part: time 4.43e-05/5.908, allocations: 8.125 kB / 3.369 GB, free: 0.8042 GB / 1.92 GB
Notification: Performance of simCode: created simulation system equations: time 0.003795/5.912, allocations: 2.59 MB / 3.372 GB, free: 0.8017 GB / 1.92 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04935/5.962, allocations: 9.945 MB / 3.381 GB, free: 0.7925 GB / 1.92 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.1987/6.16, allocations: 114.3 MB / 3.493 GB, free: 0.6769 GB / 1.92 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0113/6.172, allocations: 7.422 MB / 3.5 GB, free: 0.6696 GB / 1.92 GB
Notification: Performance of simCode: alias equations: time 0.01355/6.185, allocations: 3.164 MB / 3.503 GB, free: 0.6667 GB / 1.92 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.009997/6.195, allocations: 7.794 MB / 3.511 GB, free: 0.6591 GB / 1.92 GB
Notification: Performance of SimCode: time 1.002e-06/6.195, allocations: 0 / 3.511 GB, free: 0.6591 GB / 1.92 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.5724/6.768, allocations: 0.4918 GB / 4.003 GB, free: 173.5 MB / 1.92 GB
Notification: Performance of buildModelFMU: Generate platform static: time 58.4/65.17, allocations: 4.125 kB / 4.003 GB, free: 173.5 MB / 1.92 GB
(rm -f Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & python3 -m fmpy simulate  --output-file Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.csv --start-time 0 --stop-time 1 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.0004 Buildings_9_Buildings_Experimental_DHC_Loads_BaseClasses_Validation_BuildingWithETS.fmu > Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.csv","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Experimental_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches