Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_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 10.1.0-maint.10.0.x/package.mo", uses=false)
Using package Buildings with version 10.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.0-maint.10.0.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.Experimental.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_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS")
translateModel(Buildings.Experimental.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_10_Buildings.Experimental.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.001007/0.001007, allocations: 99.5 kB / 16.02 MB, free: 76 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001433/0.001434, allocations: 185.1 kB / 16.92 MB, free: 6.895 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.389/1.389, allocations: 223.3 MB / 241 MB, free: 5.254 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.0-maint.10.0.x/package.mo): time 2.607/2.607, allocations: 437.8 MB / 0.7128 GB, free: 6.965 MB / 0.5606 GB
Notification: Performance of FrontEnd - loaded program: time 0.000357/0.0003571, allocations: 8 kB / 0.8735 GB, free: 3.285 MB / 0.7169 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.613/0.6134, allocations: 153.8 MB / 1.024 GB, free: 15.83 MB / 0.7794 GB
Notification: Performance of NFInst.instantiate(Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 3.383/3.996, allocations: 1.342 GB / 2.366 GB, free: 54.01 MB / 1.451 GB
Notification: Performance of NFInst.instExpressions: time 0.3851/4.381, allocations: 331 MB / 2.689 GB, free: 2.23 MB / 1.467 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.05762/4.439, allocations: 1.055 MB / 2.69 GB, free: 1.168 MB / 1.467 GB
Notification: Performance of NFTyping.typeComponents: time 0.04544/4.484, allocations: 10.81 MB / 2.701 GB, free: 6.785 MB / 1.482 GB
Notification: Performance of NFTyping.typeBindings: time 0.09959/4.584, allocations: 29.44 MB / 2.73 GB, free: 13.9 MB / 1.514 GB
Notification: Performance of NFTyping.typeClassSections: time 0.05404/4.638, allocations: 18.13 MB / 2.747 GB, free: 13.79 MB / 1.529 GB
Notification: Performance of NFFlatten.flatten: time 0.09761/4.736, allocations: 75.86 MB / 2.821 GB, free: 3.41 MB / 1.592 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.04489/4.781, allocations: 18.39 MB / 2.839 GB, free: 1.156 MB / 1.607 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05682/4.837, allocations: 20.28 MB / 2.859 GB, free: 13.89 MB / 1.639 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.03313/4.871, allocations: 16.91 MB / 2.876 GB, free: 14.1 MB / 1.654 GB
Notification: Performance of NFPackage.collectConstants: time 0.007007/4.878, allocations: 0.6289 MB / 2.876 GB, free: 13.47 MB / 1.654 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.04588/4.924, allocations: 15.58 MB / 2.892 GB, free: 14.59 MB / 1.67 GB
Notification: Performance of NFScalarize.scalarize: time 0.008643/4.932, allocations: 3.256 MB / 2.895 GB, free: 11.39 MB / 1.67 GB
Notification: Performance of NFVerifyModel.verify: time 0.02353/4.956, allocations: 9.339 MB / 2.904 GB, free: 2.074 MB / 1.67 GB
Notification: Performance of NFConvertDAE.convert: time 2.172/7.128, allocations: 33.12 MB / 2.936 GB, free: 104.8 MB / 1.67 GB
Notification: Performance of FrontEnd - DAE generated: time 8.856e-06/7.128, allocations: 1.781 kB / 2.936 GB, free: 104.8 MB / 1.67 GB
Notification: Performance of FrontEnd: time 4.188e-06/7.128, allocations: 3.938 kB / 2.936 GB, free: 104.8 MB / 1.67 GB
Notification: Performance of Transformations before backend: time 0.001529/7.129, allocations: 1.094 kB / 2.936 GB, free: 104.8 MB / 1.67 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.05544/7.185, allocations: 16.76 MB / 2.953 GB, free: 98.12 MB / 1.67 GB
Notification: Performance of prepare preOptimizeDAE: time 4.712e-05/7.185, allocations: 9.844 kB / 2.953 GB, free: 98.12 MB / 1.67 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01144/7.196, allocations: 2.256 MB / 2.955 GB, free: 97.06 MB / 1.67 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.04282/7.239, allocations: 18.07 MB / 2.972 GB, free: 94.39 MB / 1.67 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001406/7.241, allocations: 0.9775 MB / 2.973 GB, free: 94.36 MB / 1.67 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.005597/7.246, allocations: 1.29 MB / 2.975 GB, free: 94.35 MB / 1.67 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.04832/7.295, allocations: 14.49 MB / 2.989 GB, free: 92.28 MB / 1.67 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.001014/7.296, allocations: 37.66 kB / 2.989 GB, free: 92.28 MB / 1.67 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004432/7.3, allocations: 0.5291 MB / 2.989 GB, free: 92.28 MB / 1.67 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004966/7.301, allocations: 351.9 kB / 2.99 GB, free: 92.28 MB / 1.67 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0243/7.325, allocations: 10.09 MB / 2.999 GB, free: 92.22 MB / 1.67 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.1127/7.438, allocations: 74.81 MB / 3.073 GB, free: 53.57 MB / 1.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007404/7.445, allocations: 4.579 MB / 3.077 GB, free: 52.87 MB / 1.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004212/7.449, allocations: 2.428 MB / 3.079 GB, free: 52.64 MB / 1.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0863/7.536, allocations: 51.88 MB / 3.13 GB, free: 26.39 MB / 1.686 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002393/7.536, allocations: 126.9 kB / 3.13 GB, free: 26.33 MB / 1.686 GB
Notification: Performance of pre-optimization done (n=412): time 8.276e-06/7.536, allocations: 0 / 3.13 GB, free: 26.33 MB / 1.686 GB
Notification: Performance of matching and sorting (n=412): time 0.01965/7.556, allocations: 6.981 MB / 3.137 GB, free: 24.74 MB / 1.686 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004275/7.556, allocations: 0.7881 MB / 3.138 GB, free: 23.83 MB / 1.686 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.04316/7.599, allocations: 16.45 MB / 3.154 GB, free: 20.36 MB / 1.686 GB
Notification: Performance of collectPreVariables (initialization): time 0.001661/7.601, allocations: 146.1 kB / 3.154 GB, free: 20.32 MB / 1.686 GB
Notification: Performance of collectInitialEqns (initialization): time 0.01239/7.613, allocations: 8.648 MB / 3.162 GB, free: 17.75 MB / 1.686 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003241/7.617, allocations: 1.46 MB / 3.164 GB, free: 16.7 MB / 1.686 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001589/7.618, allocations: 0.5057 MB / 3.164 GB, free: 16.59 MB / 1.686 GB
Notification: Performance of setup shared object (initialization): time 0.0001253/7.618, allocations: 301.1 kB / 3.165 GB, free: 16.29 MB / 1.686 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003959/7.622, allocations: 2.044 MB / 3.167 GB, free: 16.02 MB / 1.686 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.006336/7.629, allocations: 5.088 MB / 3.172 GB, free: 12.23 MB / 1.686 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.009041/7.638, allocations: 6.879 MB / 3.178 GB, free: 9.02 MB / 1.686 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001093/7.638, allocations: 23.66 kB / 3.178 GB, free: 9.02 MB / 1.686 GB
Notification: Performance of matching and sorting (n=821) (initialization): time 0.02161/7.66, allocations: 8.161 MB / 3.186 GB, free: 7.434 MB / 1.686 GB
Notification: Performance of prepare postOptimizeDAE: time 7.541e-05/7.66, allocations: 36.94 kB / 3.186 GB, free: 7.434 MB / 1.686 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.941e-05/7.66, allocations: 80.17 kB / 3.186 GB, free: 7.434 MB / 1.686 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001263/7.66, allocations: 111.8 kB / 3.187 GB, free: 7.434 MB / 1.686 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005406/7.665, allocations: 1.405 MB / 3.188 GB, free: 7.277 MB / 1.686 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001731/7.665, allocations: 166.5 kB / 3.188 GB, free: 7.258 MB / 1.686 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01763/7.683, allocations: 1.852 MB / 3.19 GB, free: 6.242 MB / 1.686 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002206/7.685, allocations: 385.8 kB / 3.19 GB, free: 6.211 MB / 1.686 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.01288/7.698, allocations: 3.552 MB / 3.194 GB, free: 5.84 MB / 1.686 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006573/7.705, allocations: 1.653 MB / 3.195 GB, free: 4.961 MB / 1.686 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01715/7.722, allocations: 7.583 MB / 3.203 GB, free: 3.465 MB / 1.686 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001939/7.722, allocations: 80.78 kB / 3.203 GB, free: 3.449 MB / 1.686 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.095e-05/7.722, allocations: 7.469 kB / 3.203 GB, free: 3.449 MB / 1.686 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004721/7.727, allocations: 3.841 MB / 3.207 GB, free: 1.426 MB / 1.686 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.06435/7.791, allocations: 28.88 MB / 3.235 GB, free: 64 kB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001161/7.792, allocations: 33.2 kB / 3.235 GB, free: 32 kB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003393/7.795, allocations: 0.7715 MB / 3.236 GB, free: 15.34 MB / 1.717 GB
Notification: Performance of postOpt tearingSystem (simulation): time 7.122e-05/7.795, allocations: 52 kB / 3.236 GB, free: 15.29 MB / 1.717 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0007176/7.796, allocations: 153.3 kB / 3.236 GB, free: 15.2 MB / 1.717 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 5.754e-05/7.796, allocations: 70.03 kB / 3.236 GB, free: 15.14 MB / 1.717 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.164e-05/7.796, allocations: 48.94 kB / 3.236 GB, free: 15.11 MB / 1.717 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02275/7.819, allocations: 11.97 MB / 3.248 GB, free: 5.543 MB / 1.717 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01184/7.831, allocations: 3.123 MB / 3.251 GB, free: 3.328 MB / 1.717 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006782/7.837, allocations: 129.6 kB / 3.251 GB, free: 3.266 MB / 1.717 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01408/7.852, allocations: 0.6114 MB / 3.251 GB, free: 2.723 MB / 1.717 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001338/7.853, allocations: 399.4 kB / 3.252 GB, free: 2.406 MB / 1.717 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.000954/7.854, allocations: 260.4 kB / 3.252 GB, free: 2.195 MB / 1.717 GB
Notification: Performance of sorting global known variables: time 0.03151/7.885, allocations: 11.7 MB / 3.263 GB, free: 10.39 MB / 1.733 GB
Notification: Performance of sort global known variables: time 2.7e-07/7.885, allocations: 0 / 3.263 GB, free: 10.39 MB / 1.733 GB
Notification: Performance of remove unused functions: time 0.02799/7.913, allocations: 5.289 MB / 3.269 GB, free: 5.551 MB / 1.733 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.01861/7.932, allocations: 4.717 MB / 3.273 GB, free: 1.43 MB / 1.733 GB
Notification: Performance of simCode: created initialization part: time 0.01194/7.944, allocations: 5.491 MB / 3.278 GB, free: 13.84 MB / 1.748 GB
Notification: Performance of simCode: created event and clocks part: time 5.164e-05/7.944, allocations: 11 kB / 3.278 GB, free: 13.83 MB / 1.748 GB
Notification: Performance of simCode: created simulation system equations: time 0.00484/7.949, allocations: 2.594 MB / 3.281 GB, free: 12.17 MB / 1.748 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.1747/8.124, allocations: 12.41 MB / 3.293 GB, free: 3.09 MB / 1.748 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.06536/8.189, allocations: 34.08 MB / 3.326 GB, free: 3.766 MB / 1.779 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01555/8.205, allocations: 7.552 MB / 3.334 GB, free: 12.7 MB / 1.795 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.007601/8.212, allocations: 1.628 MB / 3.335 GB, free: 11.11 MB / 1.795 GB
Notification: Performance of SimCode: time 1.192e-06/8.212, allocations: 0 / 3.335 GB, free: 11.11 MB / 1.795 GB
Notification: Performance of Templates: time 1.138/9.35, allocations: 316.3 MB / 3.644 GB, free: 1.112 GB / 2.061 GB
make -j1 -f Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.makefile
(rm -f Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & ./Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1)
diffSimulationResults("Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_10.0.x/Buildings_Experimental_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_10_Buildings.Experimental.DHC.Loads.BaseClasses.Validation.BuildingWithETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches