Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001946/0.001946, allocations: 80.3 kB / 19.18 MB, free: 2.516 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002397/0.002397, allocations: 159.4 kB / 22.45 MB, free: 5.375 MB / 14.72 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.432/1.432, allocations: 177.2 MB / 202.8 MB, free: 9.152 MB / 190.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo): time 2.736/2.736, allocations: 359 MB / 0.6037 GB, free: 14.91 MB / 0.5762 GB " [Timeout remaining time 177] Using package Buildings with version 11.1.2 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.2-maint.11.x/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,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_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS") translateModel(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,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_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS") [Timeout 300] "Notification: Performance of FrontEnd - loaded program: time 1.633e-06/1.633e-06, allocations: 0 / 0.951 GB, free: 11.48 MB / 0.8575 GB Notification: Performance of FrontEnd - Absyn->SCode: time 2.418e-05/2.581e-05, allocations: 2.281 kB / 0.951 GB, free: 11.48 MB / 0.8575 GB Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS): time 2.622/2.622, allocations: 1.247 GB / 2.198 GB, free: 11.21 MB / 1.592 GB Notification: Performance of NFInst.instExpressions: time 1.549/4.17, allocations: 311.1 MB / 2.502 GB, free: 80.99 MB / 1.623 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.06932/4.24, allocations: 1.691 MB / 2.504 GB, free: 80.99 MB / 1.623 GB Notification: Performance of NFTyping.typeComponents: time 0.04601/4.286, allocations: 13.61 MB / 2.517 GB, free: 76.25 MB / 1.623 GB Notification: Performance of NFTyping.typeBindings: time 0.1139/4.4, allocations: 34.9 MB / 2.551 GB, free: 56.61 MB / 1.623 GB Notification: Performance of NFTyping.typeClassSections: time 0.05736/4.457, allocations: 21.11 MB / 2.572 GB, free: 42.38 MB / 1.623 GB Notification: Performance of NFFlatten.flatten: time 0.09682/4.554, allocations: 58.83 MB / 2.629 GB, free: 3.586 MB / 1.623 GB Notification: Performance of NFFlatten.resolveConnections: time 0.06018/4.614, allocations: 16.75 MB / 2.646 GB, free: 3.438 MB / 1.639 GB Notification: Performance of NFEvalConstants.evaluate: time 0.1317/4.746, allocations: 34.06 MB / 2.679 GB, free: 4.246 MB / 1.67 GB Notification: Performance of NFSimplifyModel.simplify: time 0.04785/4.794, allocations: 16.3 MB / 2.695 GB, free: 5.371 MB / 1.686 GB Notification: Performance of NFPackage.collectConstants: time 0.01336/4.807, allocations: 2.129 MB / 2.697 GB, free: 3.242 MB / 1.686 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0592/4.866, allocations: 15.83 MB / 2.712 GB, free: 4.254 MB / 1.701 GB Notification: Performance of NFScalarize.scalarize: time 0.01317/4.879, allocations: 5.236 MB / 2.717 GB, free: 15.31 MB / 1.717 GB Notification: Performance of NFVerifyModel.verify: time 0.02656/4.906, allocations: 7.317 MB / 2.725 GB, free: 8.277 MB / 1.717 GB Notification: Performance of NFConvertDAE.convert: time 0.09863/5.005, allocations: 42.38 MB / 2.766 GB, free: 15.61 MB / 1.764 GB Notification: Performance of FrontEnd - DAE generated: time 6.983e-06/5.005, allocations: 0 / 2.766 GB, free: 15.61 MB / 1.764 GB Notification: Performance of FrontEnd: time 2.224e-06/5.005, allocations: 4 kB / 2.766 GB, free: 15.61 MB / 1.764 GB Notification: Performance of Transformations before backend: time 0.00136/5.006, allocations: 0 / 2.766 GB, free: 15.61 MB / 1.764 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.06603/5.072, allocations: 21.34 MB / 2.787 GB, free: 10.46 MB / 1.779 GB Notification: Performance of prepare preOptimizeDAE: time 6.155e-05/5.072, allocations: 8.031 kB / 2.787 GB, free: 10.46 MB / 1.779 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01304/5.085, allocations: 2.369 MB / 2.789 GB, free: 8.074 MB / 1.779 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.05247/5.137, allocations: 18.93 MB / 2.808 GB, free: 5.75 MB / 1.795 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001257/5.139, allocations: 0.9765 MB / 2.809 GB, free: 4.773 MB / 1.795 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.005/5.144, allocations: 1.293 MB / 2.81 GB, free: 3.48 MB / 1.795 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.05014/5.194, allocations: 17.06 MB / 2.826 GB, free: 1.172 MB / 1.811 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0005266/5.194, allocations: 37.75 kB / 2.826 GB, free: 1.156 MB / 1.811 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003266/5.198, allocations: 0.5377 MB / 2.827 GB, free: 0.625 MB / 1.811 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0004513/5.198, allocations: 351.9 kB / 2.827 GB, free: 288 kB / 1.811 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02599/5.224, allocations: 10.08 MB / 2.837 GB, free: 6.441 MB / 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.1093/5.333, allocations: 56.84 MB / 2.893 GB, free: 13.73 MB / 1.889 GB Notification: Performance of preOpt comSubExp (simulation): time 0.009011/5.342, allocations: 4.344 MB / 2.897 GB, free: 9.195 MB / 1.889 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.004303/5.347, allocations: 2.286 MB / 2.899 GB, free: 6.84 MB / 1.889 GB Notification: Performance of preOpt evalFunc (simulation): time 0.08305/5.43, allocations: 22.88 MB / 2.921 GB, free: 15.96 MB / 1.92 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0002211/5.43, allocations: 123.4 kB / 2.922 GB, free: 15.84 MB / 1.92 GB Notification: Performance of pre-optimization done (n=412): time 9.528e-06/5.43, allocations: 3.984 kB / 2.922 GB, free: 15.84 MB / 1.92 GB Notification: Performance of matching and sorting (n=412): time 0.02057/5.451, allocations: 6.683 MB / 2.928 GB, free: 9.211 MB / 1.92 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0005525/5.451, allocations: 0.7919 MB / 2.929 GB, free: 8.246 MB / 1.92 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03268/5.484, allocations: 12 MB / 2.941 GB, free: 12.34 MB / 1.936 GB Notification: Performance of collectPreVariables (initialization): time 0.00163/5.485, allocations: 142.7 kB / 2.941 GB, free: 12.19 MB / 1.936 GB Notification: Performance of collectInitialEqns (initialization): time 0.01021/5.496, allocations: 8.737 MB / 2.949 GB, free: 3.441 MB / 1.936 GB Notification: Performance of collectInitialBindings (initialization): time 0.002854/5.498, allocations: 1.516 MB / 2.951 GB, free: 1.945 MB / 1.936 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.00288/5.501, allocations: 1.48 MB / 2.952 GB, free: 468 kB / 1.936 GB Notification: Performance of setup shared object (initialization): time 0.0001478/5.502, allocations: 305.1 kB / 2.953 GB, free: 160 kB / 1.936 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.003786/5.505, allocations: 2.086 MB / 2.955 GB, free: 14.07 MB / 1.951 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01024/5.516, allocations: 9.603 MB / 2.964 GB, free: 2.066 MB / 1.951 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01137/5.527, allocations: 7.146 MB / 2.971 GB, free: 9.832 MB / 1.967 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.595e-05/5.527, allocations: 24 kB / 2.971 GB, free: 9.809 MB / 1.967 GB Notification: Performance of matching and sorting (n=847) (initialization): time 0.02121/5.548, allocations: 8.046 MB / 2.979 GB, free: 1.77 MB / 1.967 GB Notification: Performance of prepare postOptimizeDAE: time 7.618e-05/5.548, allocations: 43.98 kB / 2.979 GB, free: 1.727 MB / 1.967 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001112/5.548, allocations: 80 kB / 2.979 GB, free: 1.648 MB / 1.967 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0001515/5.549, allocations: 123.9 kB / 2.979 GB, free: 1.527 MB / 1.967 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005537/5.554, allocations: 1.455 MB / 2.98 GB, free: 72 kB / 1.967 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.7534/6.307, allocations: 172 kB / 2.981 GB, free: 1.042 GB / 1.967 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01261/6.32, allocations: 0.7893 MB / 2.981 GB, free: 1.042 GB / 1.967 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002593/6.323, allocations: 394.5 kB / 2.982 GB, free: 1.042 GB / 1.967 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.01192/6.335, allocations: 3.585 MB / 2.985 GB, free: 1.042 GB / 1.967 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.006154/6.341, allocations: 1.352 MB / 2.987 GB, free: 1.042 GB / 1.967 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01841/6.359, allocations: 7.448 MB / 2.994 GB, free: 1.041 GB / 1.967 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002068/6.359, allocations: 80.44 kB / 2.994 GB, free: 1.041 GB / 1.967 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.564e-05/6.359, allocations: 11.83 kB / 2.994 GB, free: 1.041 GB / 1.967 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004837/6.364, allocations: 3.892 MB / 2.998 GB, free: 1.038 GB / 1.967 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.05614/6.42, allocations: 25.39 MB / 3.023 GB, free: 1.027 GB / 1.967 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.815e-05/6.421, allocations: 31.8 kB / 3.023 GB, free: 1.027 GB / 1.967 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003258/6.424, allocations: 0.7784 MB / 3.023 GB, free: 1.026 GB / 1.967 GB Notification: Performance of postOpt tearingSystem (simulation): time 7.321e-05/6.424, allocations: 49.91 kB / 3.023 GB, free: 1.026 GB / 1.967 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.00044/6.424, allocations: 154 kB / 3.024 GB, free: 1.026 GB / 1.967 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 6.894e-05/6.424, allocations: 73.09 kB / 3.024 GB, free: 1.026 GB / 1.967 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.113e-05/6.424, allocations: 48.09 kB / 3.024 GB, free: 1.026 GB / 1.967 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01939/6.444, allocations: 11.69 MB / 3.035 GB, free: 1.02 GB / 1.967 GB Notification: Performance of postOpt removeConstants (simulation): time 0.00761/6.451, allocations: 2.244 MB / 3.037 GB, free: 1.019 GB / 1.967 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003698/6.455, allocations: 147.7 kB / 3.037 GB, free: 1.019 GB / 1.967 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00796/6.463, allocations: 179.4 kB / 3.038 GB, free: 1.019 GB / 1.967 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0008208/6.464, allocations: 418.4 kB / 3.038 GB, free: 1.019 GB / 1.967 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006469/6.465, allocations: 261.8 kB / 3.038 GB, free: 1.019 GB / 1.967 GB Notification: Performance of sorting global known variables: time 0.01772/6.482, allocations: 8.144 MB / 3.046 GB, free: 1.016 GB / 1.967 GB Notification: Performance of sort global known variables: time 4.31e-07/6.482, allocations: 0 / 3.046 GB, free: 1.016 GB / 1.967 GB Notification: Performance of remove unused functions: time 0.02322/6.505, allocations: 5.884 MB / 3.052 GB, free: 1.015 GB / 1.967 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.01339/6.519, allocations: 4.641 MB / 3.056 GB, free: 1.014 GB / 1.967 GB Notification: Performance of simCode: created initialization part: time 0.0113/6.53, allocations: 5.515 MB / 3.062 GB, free: 1.012 GB / 1.967 GB Notification: Performance of simCode: created event and clocks part: time 7.786e-05/6.53, allocations: 10.69 kB / 3.062 GB, free: 1.012 GB / 1.967 GB Notification: Performance of simCode: created simulation system equations: time 0.004566/6.535, allocations: 2.475 MB / 3.064 GB, free: 1.011 GB / 1.967 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03746/6.572, allocations: 5.889 MB / 3.07 GB, free: 1.01 GB / 1.967 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.05643/6.629, allocations: 27.68 MB / 3.097 GB, free: 0.9883 GB / 1.967 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01498/6.644, allocations: 7.551 MB / 3.104 GB, free: 0.9831 GB / 1.967 GB Notification: Performance of simCode: alias equations: time 0.01335/6.657, allocations: 2.588 MB / 3.107 GB, free: 0.9809 GB / 1.967 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003228/6.66, allocations: 0.8362 MB / 3.108 GB, free: 0.9801 GB / 1.967 GB Notification: Performance of SimCode: time 1.453e-06/6.66, allocations: 0 / 3.108 GB, free: 0.9801 GB / 1.967 GB Notification: Performance of Templates: time 0.3771/7.037, allocations: 258.8 MB / 3.361 GB, free: 0.7307 GB / 1.967 GB " [Timeout remaining time 293] make -j1 -f Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.makefile [Timeout 300] (rm -f Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; mkfifo Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe ; head -c 1048576 < Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe >> ../files/Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.sim & ./Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS -abortSlowSimulation -alarm=400 -emit_protected -lv LOG_STATS > Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.pipe 2>&1) [Timeout 400] diffSimulationResults("Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_DHC_Loads_BaseClasses_Validation_BuildingWithETS.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.DHC.Loads.BaseClasses.Validation.BuildingWithETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300] "" [Timeout remaining time 300] Reference file matches [Calling sys.exit(0), Time elapsed: 26.10264776274562]