Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.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.001815/0.001815, allocations: 97.11 kB / 19.7 MB, free: 2.129 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.002505/0.002505, allocations: 208.9 kB / 23 MB, free: 4.934 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.619/1.619, allocations: 230.6 MB / 256.8 MB, free: 7.793 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 3.463/3.463, allocations: 0.49 GB / 0.7959 GB, free: 35.45 MB / 0.6231 GB
"
[Timeout remaining time 176]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.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.Fluid.Chillers.Examples.ElectricEIR_AirCooled,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|weaDat.weaBus.TDryBul|chi.TSet|chi.TEvaEnt|chi.TEvaLvg|chi.TConEnt|chi.TConLvg|chi.PLR1|chi.PLR2|chi.CR|chi.COP",fileNamePrefix="Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled")
translateModel(Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|weaDat.weaBus.TDryBul|chi.TSet|chi.TEvaEnt|chi.TEvaLvg|chi.TConEnt|chi.TConLvg|chi.PLR1|chi.PLR2|chi.CR|chi.COP",fileNamePrefix="Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled") [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.002091/0.002091, allocations: 75.39 kB / 1.155 GB, free: 25.2 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4644/0.4665, allocations: 176.1 MB / 1.327 GB, free: 0.9688 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled): time 0.293/0.7595, allocations: 202.8 MB / 1.525 GB, free: 5.469 MB / 1.217 GB
Notification: Performance of NFInst.instExpressions: time 0.03722/0.7967, allocations: 19.46 MB / 1.544 GB, free: 1.949 MB / 1.232 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00616/0.8028, allocations: 122.9 kB / 1.544 GB, free: 1.828 MB / 1.232 GB
Notification: Performance of NFTyping.typeComponents: time 0.006199/0.809, allocations: 1.288 MB / 1.546 GB, free: 0.5312 MB / 1.232 GB
Notification: Performance of NFTyping.typeBindings: time 0.01531/0.8243, allocations: 3.607 MB / 1.549 GB, free: 12.91 MB / 1.248 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008789/0.8331, allocations: 2.67 MB / 1.552 GB, free: 10.25 MB / 1.248 GB
Notification: Performance of NFFlatten.flatten: time 0.01099/0.8441, allocations: 6.224 MB / 1.558 GB, free: 4.02 MB / 1.248 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00422/0.8483, allocations: 2.06 MB / 1.56 GB, free: 1.887 MB / 1.248 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.008683/0.857, allocations: 2.943 MB / 1.563 GB, free: 14.95 MB / 1.264 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004112/0.8611, allocations: 1.955 MB / 1.565 GB, free: 12.99 MB / 1.264 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007344/0.8619, allocations: 292 kB / 1.565 GB, free: 12.7 MB / 1.264 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007259/0.8691, allocations: 2.53 MB / 1.567 GB, free: 10.17 MB / 1.264 GB
Notification: Performance of NFScalarize.scalarize: time 0.001674/0.8708, allocations: 0.9032 MB / 1.568 GB, free: 9.262 MB / 1.264 GB
Notification: Performance of NFVerifyModel.verify: time 0.002851/0.8737, allocations: 1.33 MB / 1.569 GB, free: 7.926 MB / 1.264 GB
Notification: Performance of NFConvertDAE.convert: time 0.01333/0.887, allocations: 5.208 MB / 1.575 GB, free: 2.699 MB / 1.264 GB
Notification: Performance of FrontEnd - DAE generated: time 1.172e-05/0.887, allocations: 3.984 kB / 1.575 GB, free: 2.695 MB / 1.264 GB
Notification: Performance of FrontEnd: time 2.975e-06/0.887, allocations: 0 / 1.575 GB, free: 2.695 MB / 1.264 GB
Notification: Performance of Transformations before backend: time 0.00014/0.8871, allocations: 0 / 1.575 GB, free: 2.695 MB / 1.264 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 497
 * Number of variables: 497
Notification: Performance of Generate backend data structure: time 0.01037/0.8975, allocations: 3.673 MB / 1.578 GB, free: 14.95 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 5.851e-05/0.8976, allocations: 8.031 kB / 1.578 GB, free: 14.95 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0087/0.9063, allocations: 1.071 MB / 1.579 GB, free: 13.87 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00678/0.9131, allocations: 2.055 MB / 1.581 GB, free: 11.75 MB / 1.279 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004452/0.9135, allocations: 286.6 kB / 1.581 GB, free: 11.45 MB / 1.279 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000616/0.9141, allocations: 204 kB / 1.582 GB, free: 11.25 MB / 1.279 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.007156/0.9213, allocations: 3.098 MB / 1.585 GB, free: 7.957 MB / 1.279 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.777e-05/0.9213, allocations: 3.938 kB / 1.585 GB, free: 7.953 MB / 1.279 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002621/0.9216, allocations: 84 kB / 1.585 GB, free: 7.871 MB / 1.279 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001064/0.9217, allocations: 75.8 kB / 1.585 GB, free: 7.797 MB / 1.279 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00687/0.9286, allocations: 2.798 MB / 1.588 GB, free: 4.996 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.0156/0.9442, allocations: 6.662 MB / 1.594 GB, free: 14.25 MB / 1.295 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007752/0.9519, allocations: 2.186 MB / 1.596 GB, free: 12.06 MB / 1.295 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002572/0.9545, allocations: 0.9961 MB / 1.597 GB, free: 11.07 MB / 1.295 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0005531/0.955, allocations: 125.2 kB / 1.597 GB, free: 10.95 MB / 1.295 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003775/0.9588, allocations: 1.741 MB / 1.599 GB, free: 9.082 MB / 1.295 GB
Notification: Performance of pre-optimization done (n=171): time 6.162e-06/0.9588, allocations: 0 / 1.599 GB, free: 9.082 MB / 1.295 GB
Notification: Performance of matching and sorting (n=171): time 0.0105/0.9693, allocations: 3.251 MB / 1.602 GB, free: 5.824 MB / 1.295 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001899/0.9695, allocations: 205.9 kB / 1.602 GB, free: 5.582 MB / 1.295 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003435/0.9729, allocations: 1.77 MB / 1.604 GB, free: 3.773 MB / 1.295 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003644/0.9733, allocations: 61.7 kB / 1.604 GB, free: 3.707 MB / 1.295 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001311/0.9746, allocations: 1.089 MB / 1.605 GB, free: 2.609 MB / 1.295 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000788/0.9754, allocations: 0.5848 MB / 1.606 GB, free: 2.02 MB / 1.295 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007136/0.9761, allocations: 359.3 kB / 1.606 GB, free: 1.66 MB / 1.295 GB
Notification: Performance of setup shared object (initialization): time 0.0001496/0.9763, allocations: 313 kB / 1.606 GB, free: 1.352 MB / 1.295 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002621/0.9789, allocations: 0.955 MB / 1.607 GB, free: 396 kB / 1.295 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 1.073/2.052, allocations: 1.858 MB / 1.609 GB, free: 276.6 MB / 1.295 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006504/2.058, allocations: 2.008 MB / 1.611 GB, free: 276.4 MB / 1.295 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.418e-05/2.058, allocations: 3.5 kB / 1.611 GB, free: 276.4 MB / 1.295 GB
Notification: Performance of matching and sorting (n=214) (initialization): time 0.008147/2.066, allocations: 2.548 MB / 1.614 GB, free: 276 MB / 1.295 GB
Notification: Performance of prepare postOptimizeDAE: time 5.68e-05/2.066, allocations: 38.42 kB / 1.614 GB, free: 276 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.65e-05/2.066, allocations: 3.812 kB / 1.614 GB, free: 276 MB / 1.295 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0007395/2.067, allocations: 96.17 kB / 1.614 GB, free: 276 MB / 1.295 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0028/2.07, allocations: 478.9 kB / 1.614 GB, free: 276 MB / 1.295 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002441/2.072, allocations: 2.11 MB / 1.616 GB, free: 274 MB / 1.295 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003481/2.076, allocations: 278.9 kB / 1.617 GB, free: 274 MB / 1.295 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002663/2.076, allocations: 75.03 kB / 1.617 GB, free: 274 MB / 1.295 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.004397/2.081, allocations: 1.385 MB / 1.618 GB, free: 273.4 MB / 1.295 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003503/2.084, allocations: 1.859 MB / 1.62 GB, free: 272.1 MB / 1.295 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.006589/2.091, allocations: 2.004 MB / 1.622 GB, free: 271.3 MB / 1.295 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.218e-05/2.091, allocations: 1.031 kB / 1.622 GB, free: 271.3 MB / 1.295 GB
Notification: Performance of matching and sorting (n=214) (initialization_lambda0): time 0.009193/2.1, allocations: 2.546 MB / 1.624 GB, free: 270.5 MB / 1.295 GB
Notification: Performance of prepare postOptimizeDAE: time 5.267e-05/2.1, allocations: 38.64 kB / 1.624 GB, free: 270.4 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.781e-05/2.1, allocations: 5.844 kB / 1.624 GB, free: 270.4 MB / 1.295 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006703/2.101, allocations: 89.14 kB / 1.624 GB, free: 270.4 MB / 1.295 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002592/2.103, allocations: 465.9 kB / 1.625 GB, free: 270.4 MB / 1.295 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001989/2.105, allocations: 1.522 MB / 1.626 GB, free: 269 MB / 1.295 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003431/2.109, allocations: 271.8 kB / 1.627 GB, free: 269 MB / 1.295 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002507/2.109, allocations: 80.88 kB / 1.627 GB, free: 269 MB / 1.295 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 14
 * Number of states: 0 ()
 * Number of discrete variables: 24 (chi.tru.y,weaDat.conTim.canRepeatWeatherFile,weaDat.conTimMin.canRepeatWeatherFile,chi.on,weaDat.decAng.tNext,$PRE.weaDat.decAng.tNext,weaDat.eqnTim.tNext,$PRE.weaDat.eqnTim.tNext,weaDat.conTim.tNext,$PRE.weaDat.conTim.tNext,weaDat.conTimMin.tNext,$PRE.weaDat.conTimMin.tNext,weaDat.locTim.tNext,$PRE.weaDat.locTim.tNext,pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (210):
 * Single equations (assignments): 206
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * Torn equation systems: 1
 * 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): 1 system
   {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): 1 system
   {(1,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007933/2.11, allocations: 291.6 kB / 1.627 GB, free: 268.7 MB / 1.295 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00068/2.11, allocations: 245.1 kB / 1.627 GB, free: 268.6 MB / 1.295 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.008214/2.119, allocations: 2.809 MB / 1.63 GB, free: 267.7 MB / 1.295 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.006318/2.125, allocations: 2.459 MB / 1.632 GB, free: 266.6 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.668e-06/2.125, allocations: 0 / 1.632 GB, free: 266.6 MB / 1.295 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002234/2.127, allocations: 0.4901 MB / 1.633 GB, free: 266.3 MB / 1.295 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005039/2.128, allocations: 35.72 kB / 1.633 GB, free: 266.3 MB / 1.295 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002349/2.13, allocations: 196.8 kB / 1.633 GB, free: 266.3 MB / 1.295 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000433/2.13, allocations: 138.3 kB / 1.633 GB, free: 266.3 MB / 1.295 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.008406/2.139, allocations: 2.601 MB / 1.636 GB, free: 265.4 MB / 1.295 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.01021/2.149, allocations: 3.851 MB / 1.639 GB, free: 263.9 MB / 1.295 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003044/2.152, allocations: 1.032 MB / 1.64 GB, free: 263.6 MB / 1.295 GB
Notification: Performance of sorting global known variables: time 0.002835/2.155, allocations: 1.202 MB / 1.642 GB, free: 263.1 MB / 1.295 GB
Notification: Performance of Backend: time 6.91e-07/2.155, allocations: 0 / 1.642 GB, free: 263.1 MB / 1.295 GB
Notification: Performance of simCode: created initialization part: time 0.014/2.169, allocations: 4.164 MB / 1.646 GB, free: 261.7 MB / 1.295 GB
Notification: Performance of SimCode: time 0.01022/2.179, allocations: 5.227 MB / 1.651 GB, free: 258.5 MB / 1.295 GB
Notification: Performance of Templates: time 0.09746/2.277, allocations: 71.48 MB / 1.721 GB, free: 188.5 MB / 1.295 GB
"
[Timeout remaining time 298]
make -j1 -f Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.pipe ; mkfifo Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.pipe >> ../files/Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.sim & ./Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Fluid_Chillers_Examples_ElectricEIR_AirCooled.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Fluid.Chillers.Examples.ElectricEIR_AirCooled.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: 14.432732886998565]