Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.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.ETS.Combined.Subsystems.Validation.Chiller,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTHeaWatSup.T|senTHeaWatRet.T|TChiWatSupSet.y|senTChiWatSup.T|senTChiWatRet.T|chi.PChi|chi.PPum|chi.valCon.y_actual|chi.valEva.y_actual|chi.uHea|chi.uCoo",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller")
translateModel(Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|senTHeaWatSup.T|senTHeaWatRet.T|TChiWatSupSet.y|senTChiWatSup.T|senTChiWatRet.T|chi.PChi|chi.PPum|chi.valCon.y_actual|chi.valEva.y_actual|chi.uHea|chi.uCoo",fileNamePrefix="Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001641/0.001641, allocations: 115.7 kB / 16.42 MB, free: 6.473 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.001972/0.001972, allocations: 183.9 kB / 17.35 MB, free: 5.75 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.54/1.54, allocations: 222.9 MB / 241.1 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 3.062/3.062, allocations: 461.9 MB / 0.7355 GB, free: 11.04 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.0018/0.001801, allocations: 55.91 kB / 1.055 GB, free: 7.703 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.302/1.304, allocations: 157.4 MB / 1.208 GB, free: 13.63 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller): time 0.2978/1.602, allocations: 259.5 MB / 1.462 GB, free: 9.262 MB / 1.186 GB
Notification: Performance of NFInst.instExpressions: time 0.09055/1.692, allocations: 53.78 MB / 1.514 GB, free: 3.363 MB / 1.232 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0224/1.715, allocations: 294.4 kB / 1.515 GB, free: 3.074 MB / 1.232 GB
Notification: Performance of NFTyping.typeComponents: time 0.01536/1.73, allocations: 4.245 MB / 1.519 GB, free: 14.81 MB / 1.248 GB
Notification: Performance of NFTyping.typeBindings: time 0.02986/1.76, allocations: 8.608 MB / 1.527 GB, free: 6.168 MB / 1.248 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02279/1.783, allocations: 7.34 MB / 1.534 GB, free: 14.87 MB / 1.264 GB
Notification: Performance of NFFlatten.flatten: time 0.04984/1.833, allocations: 29.92 MB / 1.564 GB, free: 0.8906 MB / 1.279 GB
Notification: Performance of NFFlatten.resolveConnections: time 1.217/3.05, allocations: 6.792 MB / 1.57 GB, free: 73.77 MB / 1.279 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02132/3.071, allocations: 7.52 MB / 1.578 GB, free: 73.75 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01408/3.085, allocations: 5.263 MB / 1.583 GB, free: 73.27 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.004401/3.09, allocations: 0.8744 MB / 1.584 GB, free: 73.27 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01578/3.106, allocations: 4.937 MB / 1.588 GB, free: 73.26 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.005571/3.111, allocations: 2.295 MB / 1.591 GB, free: 72.97 MB / 1.279 GB
Notification: Performance of NFVerifyModel.verify: time 0.01152/3.123, allocations: 4.449 MB / 1.595 GB, free: 71.8 MB / 1.279 GB
Notification: Performance of NFConvertDAE.convert: time 0.02969/3.152, allocations: 14.9 MB / 1.61 GB, free: 70.48 MB / 1.279 GB
Notification: Performance of FrontEnd - DAE generated: time 8.426e-06/3.152, allocations: 0 / 1.61 GB, free: 70.48 MB / 1.279 GB
Notification: Performance of FrontEnd: time 2.124e-06/3.152, allocations: 0 / 1.61 GB, free: 70.48 MB / 1.279 GB
Notification: Performance of Transformations before backend: time 0.0004946/3.153, allocations: 0 / 1.61 GB, free: 70.48 MB / 1.279 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 957
 * Number of variables: 957
Notification: Performance of Generate backend data structure: time 0.02924/3.182, allocations: 8.828 MB / 1.618 GB, free: 66.75 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 5.869e-05/3.182, allocations: 8.906 kB / 1.618 GB, free: 66.75 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01054/3.193, allocations: 1.594 MB / 1.62 GB, free: 66.32 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02154/3.214, allocations: 8.7 MB / 1.628 GB, free: 65.04 MB / 1.279 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005778/3.215, allocations: 385.8 kB / 1.629 GB, free: 64.96 MB / 1.279 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001919/3.217, allocations: 408 kB / 1.629 GB, free: 64.96 MB / 1.279 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01198/3.229, allocations: 5.003 MB / 1.634 GB, free: 64.43 MB / 1.279 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001076/3.229, allocations: 14.09 kB / 1.634 GB, free: 64.43 MB / 1.279 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005296/3.23, allocations: 154.3 kB / 1.634 GB, free: 64.43 MB / 1.279 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.919e-05/3.23, allocations: 101.1 kB / 1.634 GB, free: 64.43 MB / 1.279 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01042/3.24, allocations: 4.129 MB / 1.638 GB, free: 64.37 MB / 1.279 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.04653/3.287, allocations: 25.88 MB / 1.663 GB, free: 52.64 MB / 1.279 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.008041/3.295, allocations: 3.139 MB / 1.666 GB, free: 52.38 MB / 1.279 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.003869/3.299, allocations: 1.673 MB / 1.668 GB, free: 52.34 MB / 1.279 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 evalFunc (simulation): time 0.01705/3.316, allocations: 9.144 MB / 1.677 GB, free: 47.79 MB / 1.279 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.004332/3.32, allocations: 1.98 MB / 1.679 GB, free: 47.25 MB / 1.279 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.003861/3.324, allocations: 312.7 kB / 1.679 GB, free: 47.09 MB / 1.279 GB
Notification: Performance of pre-optimization done (n=221): time 1.755e-05/3.324, allocations: 0 / 1.679 GB, free: 47.09 MB / 1.279 GB
Notification: Performance of matching and sorting (n=221): time 0.01403/3.338, allocations: 5.058 MB / 1.684 GB, free: 45.8 MB / 1.279 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.961e-05/3.338, allocations: 140.2 kB / 1.684 GB, free: 45.67 MB / 1.279 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01438/3.353, allocations: 6.333 MB / 1.691 GB, free: 44.23 MB / 1.279 GB
Notification: Performance of collectPreVariables (initialization): time 0.00122/3.354, allocations: 83.59 kB / 1.691 GB, free: 44.19 MB / 1.279 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003874/3.358, allocations: 3.037 MB / 1.694 GB, free: 43.14 MB / 1.279 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001572/3.36, allocations: 0.7516 MB / 1.694 GB, free: 42.6 MB / 1.279 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001671/3.361, allocations: 0.8896 MB / 1.695 GB, free: 42.41 MB / 1.279 GB
Notification: Performance of setup shared object (initialization): time 7.106e-05/3.361, allocations: 308.9 kB / 1.695 GB, free: 42.11 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00426/3.366, allocations: 2.356 MB / 1.698 GB, free: 41.8 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004853/3.37, allocations: 3.408 MB / 1.701 GB, free: 40.01 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0082/3.379, allocations: 5.483 MB / 1.706 GB, free: 36.66 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.143e-05/3.379, allocations: 10.47 kB / 1.706 GB, free: 36.66 MB / 1.279 GB
Notification: Performance of matching and sorting (n=518) (initialization): time 0.01323/3.392, allocations: 6.673 MB / 1.713 GB, free: 32.19 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 9.499e-05/3.392, allocations: 87.38 kB / 1.713 GB, free: 32.09 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.572e-05/3.392, allocations: 20 kB / 1.713 GB, free: 32.07 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007082/3.393, allocations: 192.9 kB / 1.713 GB, free: 31.89 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004103/3.397, allocations: 0.8589 MB / 1.714 GB, free: 31.08 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001852/3.399, allocations: 2.645 MB / 1.717 GB, free: 28.35 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006732/3.406, allocations: 259.7 kB / 1.717 GB, free: 28.09 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0009967/3.407, allocations: 203.9 kB / 1.717 GB, free: 27.89 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.008324/3.415, allocations: 3.464 MB / 1.721 GB, free: 24.43 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.005495/3.421, allocations: 3.16 MB / 1.724 GB, free: 20.86 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.00915/3.43, allocations: 4.993 MB / 1.728 GB, free: 15.59 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.72e-05/3.43, allocations: 7.938 kB / 1.728 GB, free: 15.59 MB / 1.279 GB
Notification: Performance of matching and sorting (n=518) (initialization_lambda0): time 0.01757/3.447, allocations: 6.112 MB / 1.734 GB, free: 9.57 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001006/3.448, allocations: 83.39 kB / 1.735 GB, free: 9.477 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.662e-05/3.448, allocations: 24 kB / 1.735 GB, free: 9.453 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004564/3.448, allocations: 129.7 kB / 1.735 GB, free: 9.32 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005838/3.454, allocations: 0.8533 MB / 1.736 GB, free: 8.516 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003723/3.458, allocations: 3.571 MB / 1.739 GB, free: 4.699 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01064/3.468, allocations: 279.3 kB / 1.739 GB, free: 4.43 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001717/3.47, allocations: 195.9 kB / 1.739 GB, free: 4.238 MB / 1.279 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 106
 * Number of states: 0 ()
 * Number of discrete variables: 21 (chi.chi.tru.y,chi.con.conValCon.conPID.cheYMinMax.y,chi.con.conValEva.conPID.cheYMinMax.y,TChiWatRet.nextEventScaled,TChiWatRet.nextEvent,$PRE.TChiWatRet.nextEvent,TChiWatRet.last,TChiWatRet.b,TChiWatRet.a,THeaWatRet.nextEventScaled,THeaWatRet.nextEvent,$PRE.THeaWatRet.nextEvent,THeaWatRet.last,THeaWatRet.b,THeaWatRet.a,uCoo.y,uHea.y,chi.con.yChi,$whenCondition2,$whenCondition1,$whenCondition3)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (430):
 * Single equations (assignments): 420
 * Array equations: 2
 * Algorithm blocks: 2
 * Record equations: 2
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 2 systems
   {1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(1,4), (1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.001941/3.472, allocations: 463.7 kB / 1.74 GB, free: 3.812 MB / 1.279 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003661/3.476, allocations: 0.621 MB / 1.74 GB, free: 3.184 MB / 1.279 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0151/3.491, allocations: 4.427 MB / 1.745 GB, free: 14.72 MB / 1.295 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01112/3.502, allocations: 3.269 MB / 1.748 GB, free: 11.4 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.938e-05/3.502, allocations: 0 / 1.748 GB, free: 11.4 MB / 1.295 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008699/3.511, allocations: 1.11 MB / 1.749 GB, free: 10.26 MB / 1.295 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.005222/3.516, allocations: 48 kB / 1.749 GB, free: 10.21 MB / 1.295 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009712/3.526, allocations: 214.9 kB / 1.749 GB, free: 10.01 MB / 1.295 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001317/3.527, allocations: 153.8 kB / 1.749 GB, free: 9.859 MB / 1.295 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02187/3.549, allocations: 4.008 MB / 1.753 GB, free: 5.805 MB / 1.295 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02541/3.575, allocations: 6.068 MB / 1.759 GB, free: 15.66 MB / 1.311 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.006015/3.581, allocations: 1.671 MB / 1.761 GB, free: 13.99 MB / 1.311 GB
Notification: Performance of sorting global known variables: time 0.0196/3.601, allocations: 4.246 MB / 1.765 GB, free: 9.773 MB / 1.311 GB
Notification: Performance of Backend: time 1.513e-06/3.601, allocations: 0 / 1.765 GB, free: 9.773 MB / 1.311 GB
Notification: Performance of simCode: created initialization part: time 0.04176/3.642, allocations: 8.384 MB / 1.773 GB, free: 1.652 MB / 1.311 GB
Notification: Performance of SimCode: time 0.04217/3.685, allocations: 13.99 MB / 1.787 GB, free: 3.73 MB / 1.326 GB
Notification: Performance of Templates: time 0.2763/3.961, allocations: 146.9 MB / 1.93 GB, free: 2.926 MB / 1.467 GB
make -j1 -f Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.makefile
(rm -f Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.pipe ; mkfifo Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.pipe ; head -c 1048576 < Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.pipe >> ../files/Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.sim & ./Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_DHC_ETS_Combined_Subsystems_Validation_Chiller.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.DHC.ETS.Combined.Subsystems.Validation.Chiller.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches