Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.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.001888/0.001888, allocations: 99.64 kB / 18.94 MB, free: 2.551 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.002387/0.002387, allocations: 211.3 kB / 22.24 MB, free: 4.859 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.6/1.6, allocations: 230.6 MB / 256 MB, free: 7.785 MB / 206.1 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/package.mo): time 3.445/3.445, allocations: 0.5107 GB / 0.8158 GB, free: 17.8 MB / 0.6231 GB " [Timeout remaining time 176] Using package Buildings with version 13.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings master/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.Plants.Combined.Subsystems.Validation.ChillerGroup,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|y1.y.1.|y1.y.2.|chi.m2_flow|chi.chi.m2_flow|TChiWatSupSet.y|chi.sta_a2.T|chi.sta_b2.T|chi.sta_a1.T|chi.sta_b1.T|chi.chi.PLR1|chi.chi.PLR2|dat.PLRMax|chi.chi.COP",fileNamePrefix="Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup") translateModel(Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|y1.y.1.|y1.y.2.|chi.m2_flow|chi.chi.m2_flow|TChiWatSupSet.y|chi.sta_a2.T|chi.sta_b2.T|chi.sta_a1.T|chi.sta_b1.T|chi.chi.PLR1|chi.chi.PLR2|dat.PLRMax|chi.chi.COP",fileNamePrefix="Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup") [Timeout 300] "Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Performance of FrontEnd - loaded program: time 0.002151/0.002151, allocations: 67.45 kB / 1.186 GB, free: 13.51 MB / 0.9044 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3901/0.3922, allocations: 181.9 MB / 1.364 GB, free: 13.58 MB / 1.061 GB Notification: Performance of NFInst.instantiate(Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup): time 0.2461/0.6383, allocations: 218.1 MB / 1.577 GB, free: 2.75 MB / 1.264 GB Notification: Performance of NFInst.instExpressions: time 0.9717/1.61, allocations: 40.52 MB / 1.616 GB, free: 54.83 MB / 1.295 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.009714/1.62, allocations: 333.4 kB / 1.617 GB, free: 54.83 MB / 1.295 GB Notification: Performance of NFTyping.typeComponents: time 0.0113/1.631, allocations: 3.137 MB / 1.62 GB, free: 54.83 MB / 1.295 GB Notification: Performance of NFTyping.typeBindings: time 0.03596/1.667, allocations: 8.298 MB / 1.628 GB, free: 54.72 MB / 1.295 GB Notification: Performance of NFTyping.typeClassSections: time 0.01753/1.684, allocations: 5.794 MB / 1.634 GB, free: 54.59 MB / 1.295 GB Notification: Performance of NFFlatten.flatten: time 0.04644/1.731, allocations: 27.09 MB / 1.66 GB, free: 54.55 MB / 1.295 GB Notification: Performance of NFFlatten.resolveConnections: time 0.01895/1.75, allocations: 7.532 MB / 1.667 GB, free: 54.05 MB / 1.295 GB Notification: Performance of NFEvalConstants.evaluate: time 0.02846/1.778, allocations: 10.45 MB / 1.678 GB, free: 53.27 MB / 1.295 GB Notification: Performance of NFSimplifyModel.simplify: time 0.01705/1.795, allocations: 7.315 MB / 1.685 GB, free: 52.11 MB / 1.295 GB Notification: Performance of NFPackage.collectConstants: time 0.004783/1.8, allocations: 1.046 MB / 1.686 GB, free: 52.11 MB / 1.295 GB Notification: Performance of NFFlatten.collectFunctions: time 0.01588/1.816, allocations: 3.003 MB / 1.689 GB, free: 52.05 MB / 1.295 GB Notification: Performance of NFScalarize.scalarize: time 0.006909/1.823, allocations: 2.699 MB / 1.691 GB, free: 51.25 MB / 1.295 GB Notification: Performance of NFVerifyModel.verify: time 0.01661/1.84, allocations: 4.277 MB / 1.695 GB, free: 49 MB / 1.295 GB Notification: Performance of NFConvertDAE.convert: time 0.04024/1.88, allocations: 18.45 MB / 1.714 GB, free: 41.9 MB / 1.295 GB Notification: Performance of FrontEnd - DAE generated: time 7.043e-06/1.88, allocations: 0 / 1.714 GB, free: 41.9 MB / 1.295 GB Notification: Performance of FrontEnd: time 2.074e-06/1.88, allocations: 0 / 1.714 GB, free: 41.9 MB / 1.295 GB Notification: Performance of Transformations before backend: time 0.0007498/1.881, allocations: 2.688 kB / 1.714 GB, free: 41.9 MB / 1.295 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1232 * Number of variables: 1232 Notification: Performance of Generate backend data structure: time 0.04194/1.923, allocations: 10.5 MB / 1.724 GB, free: 34.85 MB / 1.295 GB Notification: Performance of prepare preOptimizeDAE: time 7.728e-05/1.923, allocations: 15.66 kB / 1.724 GB, free: 34.85 MB / 1.295 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01181/1.934, allocations: 1.491 MB / 1.725 GB, free: 34.13 MB / 1.295 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.02824/1.963, allocations: 11.13 MB / 1.736 GB, free: 26.54 MB / 1.295 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006599/1.963, allocations: 0.509 MB / 1.737 GB, free: 26.23 MB / 1.295 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.002768/1.966, allocations: 0.521 MB / 1.737 GB, free: 26.06 MB / 1.295 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02038/1.986, allocations: 8.221 MB / 1.745 GB, free: 20.56 MB / 1.295 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.000151/1.987, allocations: 13.86 kB / 1.745 GB, free: 20.55 MB / 1.295 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0007198/1.987, allocations: 201.3 kB / 1.745 GB, free: 20.4 MB / 1.295 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001458/1.987, allocations: 135.8 kB / 1.745 GB, free: 20.39 MB / 1.295 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0164/2.004, allocations: 6.379 MB / 1.752 GB, free: 16.66 MB / 1.295 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.05865/2.063, allocations: 23.82 MB / 1.775 GB, free: 8.754 MB / 1.311 GB Notification: Performance of preOpt comSubExp (simulation): time 0.007079/2.07, allocations: 2.492 MB / 1.777 GB, free: 6.262 MB / 1.311 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.004623/2.074, allocations: 1.752 MB / 1.779 GB, free: 4.512 MB / 1.311 GB Notification: Performance of preOpt evalFunc (simulation): time 0.001158/2.075, allocations: 237.8 kB / 1.779 GB, free: 4.281 MB / 1.311 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.005793/2.081, allocations: 2.757 MB / 1.782 GB, free: 1.309 MB / 1.311 GB Notification: Performance of pre-optimization done (n=212): time 5.941e-06/2.081, allocations: 3.656 kB / 1.782 GB, free: 1.309 MB / 1.311 GB Notification: Performance of matching and sorting (n=212): time 0.01616/2.097, allocations: 5.09 MB / 1.787 GB, free: 12.21 MB / 1.326 GB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001153/2.097, allocations: 85.39 kB / 1.787 GB, free: 12.12 MB / 1.326 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02313/2.121, allocations: 8.319 MB / 1.795 GB, free: 3.844 MB / 1.326 GB Notification: Performance of collectPreVariables (initialization): time 0.001224/2.122, allocations: 85.7 kB / 1.795 GB, free: 3.754 MB / 1.326 GB Notification: Performance of collectInitialEqns (initialization): time 0.0071/2.129, allocations: 3.866 MB / 1.799 GB, free: 15.88 MB / 1.342 GB Notification: Performance of collectInitialBindings (initialization): time 0.002019/2.131, allocations: 0.7791 MB / 1.8 GB, free: 15.11 MB / 1.342 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.003308/2.134, allocations: 0.7806 MB / 1.801 GB, free: 14.32 MB / 1.342 GB Notification: Performance of setup shared object (initialization): time 0.0001523/2.134, allocations: 313 kB / 1.801 GB, free: 14.02 MB / 1.342 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.004505/2.139, allocations: 1.747 MB / 1.803 GB, free: 12.27 MB / 1.342 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.007698/2.147, allocations: 5.199 MB / 1.808 GB, free: 5.988 MB / 1.342 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01006/2.157, allocations: 4.437 MB / 1.812 GB, free: 1.098 MB / 1.342 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.574e-05/2.157, allocations: 8 kB / 1.812 GB, free: 1.09 MB / 1.342 GB Notification: Performance of matching and sorting (n=402) (initialization): time 0.01654/2.173, allocations: 5.185 MB / 1.817 GB, free: 11.85 MB / 1.357 GB Notification: Performance of prepare postOptimizeDAE: time 7.264e-05/2.173, allocations: 20 kB / 1.817 GB, free: 11.83 MB / 1.357 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.646e-05/2.173, allocations: 32 kB / 1.817 GB, free: 11.8 MB / 1.357 GB Notification: Performance of postOpt tearingSystem (initialization): time 9.745e-05/2.173, allocations: 48 kB / 1.817 GB, free: 11.75 MB / 1.357 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004015/2.178, allocations: 0.8271 MB / 1.818 GB, free: 10.93 MB / 1.357 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001193/2.178, allocations: 67.78 kB / 1.818 GB, free: 10.86 MB / 1.357 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008547/2.186, allocations: 0.5762 MB / 1.819 GB, free: 10.28 MB / 1.357 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0007775/2.187, allocations: 159.9 kB / 1.819 GB, free: 10.12 MB / 1.357 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 140 * Number of states: 0 () * Number of discrete variables: 16 ($whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,chi.chi.tru.y,y1.intTimTab.idx,$PRE.y1.intTimTab.idx,y1.intTimTab.y[2],$PRE.y1.intTimTab.y[2],y1.intTimTab.y[1],$PRE.y1.intTimTab.y[1],y1.y[2],chi.com.y1One,chi.y1[1]) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (402): * Single equations (assignments): 402 * 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.008041/2.195, allocations: 3.042 MB / 1.822 GB, free: 7.07 MB / 1.357 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00383/2.199, allocations: 0.6831 MB / 1.822 GB, free: 6.383 MB / 1.357 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01245/2.211, allocations: 4.203 MB / 1.827 GB, free: 2.184 MB / 1.357 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.923e-05/2.211, allocations: 20 kB / 1.827 GB, free: 2.164 MB / 1.357 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.267e-05/2.211, allocations: 0 / 1.827 GB, free: 2.164 MB / 1.357 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.007726/2.219, allocations: 3.355 MB / 1.83 GB, free: 14.76 MB / 1.373 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 postOpt removeSimpleEquations (simulation): time 0.0299/2.249, allocations: 9.629 MB / 1.839 GB, free: 5.129 MB / 1.373 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.513e-05/2.249, allocations: 3.984 kB / 1.839 GB, free: 5.125 MB / 1.373 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002795/2.252, allocations: 0.5619 MB / 1.84 GB, free: 4.562 MB / 1.373 GB Notification: Performance of postOpt tearingSystem (simulation): time 3.365e-05/2.252, allocations: 12 kB / 1.84 GB, free: 4.551 MB / 1.373 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003365/2.252, allocations: 71.94 kB / 1.84 GB, free: 4.48 MB / 1.373 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.681e-05/2.252, allocations: 8 kB / 1.84 GB, free: 4.473 MB / 1.373 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.25e-06/2.252, allocations: 7.938 kB / 1.84 GB, free: 4.465 MB / 1.373 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01471/2.267, allocations: 6.325 MB / 1.846 GB, free: 14.09 MB / 1.389 GB Notification: Performance of postOpt removeConstants (simulation): time 0.005335/2.272, allocations: 1.329 MB / 1.847 GB, free: 12.77 MB / 1.389 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002895/2.275, allocations: 48 kB / 1.847 GB, free: 12.72 MB / 1.389 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006134/2.281, allocations: 295.4 kB / 1.848 GB, free: 12.44 MB / 1.389 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003762/2.282, allocations: 153.7 kB / 1.848 GB, free: 12.29 MB / 1.389 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0004505/2.282, allocations: 115.9 kB / 1.848 GB, free: 12.18 MB / 1.389 GB Notification: Performance of sorting global known variables: time 0.01563/2.298, allocations: 5.861 MB / 1.854 GB, free: 6.355 MB / 1.389 GB Notification: Performance of sort global known variables: time 2.5e-07/2.298, allocations: 0 / 1.854 GB, free: 6.355 MB / 1.389 GB Notification: Performance of remove unused functions: time 0.01023/2.308, allocations: 2.171 MB / 1.856 GB, free: 4.18 MB / 1.389 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 9 * Number of states: 16 (chi.chi.vol1.dynBal.U,chi.chi.vol2.dynBal.U,chi.valEva.junInl[1].vol.dynBal.U,chi.valEva.junInl[2].vol.dynBal.U,chi.valEva.junOut[1].vol.dynBal.U,chi.valEva.junOut[2].vol.dynBal.U,chi.valEva.val[1].actPos.y,chi.valEva.val[2].actPos.y,chi.valCon.junInl[1].vol.dynBal.U,chi.valCon.junInl[2].vol.dynBal.U,chi.valCon.junOut[1].vol.dynBal.U,chi.valCon.junOut[2].vol.dynBal.U,chi.valCon.val[1].actPos.y,chi.valCon.val[2].actPos.y,chi.temConLvg.T,chi.temEvaLvg.T) * Number of discrete variables: 12 ($whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,chi.y1[1],chi.com.y1One,y1.y[2],y1.intTimTab.y[1],y1.intTimTab.y[2],y1.intTimTab.idx) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (222): * Single equations (assignments): 209 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 10 * When equations: 3 * 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.003236/2.311, allocations: 1.067 MB / 1.857 GB, free: 3.203 MB / 1.389 GB Notification: Performance of simCode: created initialization part: time 0.01017/2.321, allocations: 3.862 MB / 1.861 GB, free: 15.34 MB / 1.404 GB Notification: Performance of simCode: created event and clocks part: time 8.897e-06/2.321, allocations: 0 / 1.861 GB, free: 15.34 MB / 1.404 GB Notification: Performance of simCode: created simulation system equations: time 0.004221/2.326, allocations: 1.66 MB / 1.862 GB, free: 13.68 MB / 1.404 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02137/2.347, allocations: 3.744 MB / 1.866 GB, free: 10.09 MB / 1.404 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03984/2.387, allocations: 15.97 MB / 1.881 GB, free: 10.2 MB / 1.42 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00859/2.395, allocations: 5.025 MB / 1.886 GB, free: 5.141 MB / 1.42 GB Notification: Performance of simCode: alias equations: time 0.009099/2.404, allocations: 1.933 MB / 1.888 GB, free: 3.238 MB / 1.42 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002809/2.407, allocations: 0.4915 MB / 1.889 GB, free: 2.746 MB / 1.42 GB Notification: Performance of SimCode: time 9.42e-07/2.407, allocations: 0 / 1.889 GB, free: 2.746 MB / 1.42 GB Notification: Performance of Templates: time 0.2697/2.677, allocations: 151.6 MB / 2.037 GB, free: 13.08 MB / 1.576 GB " [Timeout remaining time 297] make -j1 -f Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.makefile [Timeout 300] (rm -f Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.pipe ; mkfifo Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.pipe >> ../files/Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.sim & ./Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup -abortSlowSimulation -alarm=800 -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.pipe 2>&1) [Timeout 800] diffSimulationResults("Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_DHC_Plants_Combined_Subsystems_Validation_ChillerGroup.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.DHC.Plants.Combined.Subsystems.Validation.ChillerGroup.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: 15.791260877624154]