Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.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 9.1.3-maint.9.1.x/package.mo", uses=false)
Using package Buildings with version 9.1.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.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.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|TSet.y|TOut.y|TVol.T|THeaOut.T|hea.TSet|hea.Q_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T")
translateModel(Buildings.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|TSet.y|TOut.y|TVol.T|THeaOut.T|hea.TSet|hea.Q_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001426/0.001426, allocations: 112.7 kB / 16.42 MB, free: 6.512 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.001625/0.001625, allocations: 190.7 kB / 17.35 MB, free: 5.738 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.328/1.328, allocations: 222.9 MB / 241 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.3-maint.9.1.x/package.mo): time 2.233/2.233, allocations: 390.3 MB / 0.6655 GB, free: 0.668 MB / 0.5294 GB
Notification: Performance of FrontEnd - loaded program: time 0.001534/0.001534, allocations: 63.91 kB / 0.9516 GB, free: 7.613 MB / 0.7325 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.8132/0.8147, allocations: 140.4 MB / 1.089 GB, free: 5.516 MB / 0.8575 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter mov.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.Examples.AirHeater_T): time 0.2732/1.088, allocations: 236 MB / 1.319 GB, free: 1.488 MB / 1.045 GB
Notification: Performance of NFInst.instExpressions: time 0.02563/1.114, allocations: 15.75 MB / 1.334 GB, free: 1.699 MB / 1.061 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003219/1.117, allocations: 87.5 kB / 1.335 GB, free: 1.613 MB / 1.061 GB
Notification: Performance of NFTyping.typeComponents: time 0.0042/1.121, allocations: 1.346 MB / 1.336 GB, free: 272 kB / 1.061 GB
Notification: Performance of NFTyping.typeBindings: time 0.0105/1.132, allocations: 3.548 MB / 1.339 GB, free: 12.71 MB / 1.076 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006747/1.138, allocations: 2.507 MB / 1.342 GB, free: 10.21 MB / 1.076 GB
Notification: Performance of NFFlatten.flatten: time 0.007607/1.146, allocations: 4.981 MB / 1.347 GB, free: 5.227 MB / 1.076 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003274/1.149, allocations: 1.91 MB / 1.349 GB, free: 3.266 MB / 1.076 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005945/1.155, allocations: 2.775 MB / 1.351 GB, free: 492 kB / 1.076 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003293/1.159, allocations: 1.557 MB / 1.353 GB, free: 14.92 MB / 1.092 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007044/1.159, allocations: 196 kB / 1.353 GB, free: 14.73 MB / 1.092 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007123/1.166, allocations: 3.438 MB / 1.356 GB, free: 11.29 MB / 1.092 GB
Notification: Performance of NFScalarize.scalarize: time 0.001167/1.168, allocations: 0.7516 MB / 1.357 GB, free: 10.53 MB / 1.092 GB
Notification: Performance of NFVerifyModel.verify: time 0.002296/1.17, allocations: 1.197 MB / 1.358 GB, free: 9.328 MB / 1.092 GB
Notification: Performance of NFConvertDAE.convert: time 0.007575/1.178, allocations: 4.312 MB / 1.362 GB, free: 5.004 MB / 1.092 GB
Notification: Performance of FrontEnd - DAE generated: time 4.819e-06/1.178, allocations: 0 / 1.362 GB, free: 5.004 MB / 1.092 GB
Notification: Performance of FrontEnd: time 1.343e-06/1.178, allocations: 0 / 1.362 GB, free: 5.004 MB / 1.092 GB
Notification: Performance of Transformations before backend: time 0.0001025/1.178, allocations: 0 / 1.362 GB, free: 5.004 MB / 1.092 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 333
 * Number of variables: 333
Notification: Performance of Generate backend data structure: time 0.006058/1.184, allocations: 2.822 MB / 1.365 GB, free: 2.113 MB / 1.092 GB
Notification: Performance of prepare preOptimizeDAE: time 3.827e-05/1.184, allocations: 8.031 kB / 1.365 GB, free: 2.105 MB / 1.092 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005688/1.189, allocations: 0.8556 MB / 1.366 GB, free: 1.246 MB / 1.092 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003999/1.193, allocations: 1.769 MB / 1.368 GB, free: 15.42 MB / 1.107 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000111/1.194, allocations: 106.6 kB / 1.368 GB, free: 15.32 MB / 1.107 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003235/1.194, allocations: 136 kB / 1.368 GB, free: 15.18 MB / 1.107 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003813/1.198, allocations: 1.678 MB / 1.37 GB, free: 13.43 MB / 1.107 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.843e-05/1.198, allocations: 7.984 kB / 1.37 GB, free: 13.42 MB / 1.107 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001707/1.198, allocations: 52 kB / 1.37 GB, free: 13.37 MB / 1.107 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.887e-05/1.198, allocations: 54.48 kB / 1.37 GB, free: 13.32 MB / 1.107 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003681/1.202, allocations: 1.462 MB / 1.371 GB, free: 11.85 MB / 1.107 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.01247/1.214, allocations: 7.782 MB / 1.379 GB, free: 3.496 MB / 1.107 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002839/1.217, allocations: 1.611 MB / 1.38 GB, free: 1.746 MB / 1.107 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001202/1.218, allocations: 0.5376 MB / 1.381 GB, free: 1.207 MB / 1.107 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001276/1.22, allocations: 0.7669 MB / 1.382 GB, free: 300 kB / 1.107 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001322/1.221, allocations: 0.5791 MB / 1.382 GB, free: 15.7 MB / 1.123 GB
Notification: Performance of pre-optimization done (n=83): time 3.617e-06/1.221, allocations: 0 / 1.382 GB, free: 15.7 MB / 1.123 GB
Notification: Performance of matching and sorting (n=83): time 0.004462/1.225, allocations: 1.644 MB / 1.384 GB, free: 14.03 MB / 1.123 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.403e-05/1.225, allocations: 64.41 kB / 1.384 GB, free: 13.95 MB / 1.123 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002489/1.228, allocations: 1.563 MB / 1.385 GB, free: 12.39 MB / 1.123 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001254/1.228, allocations: 49.7 kB / 1.385 GB, free: 12.34 MB / 1.123 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008392/1.229, allocations: 0.9202 MB / 1.386 GB, free: 11.41 MB / 1.123 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003153/1.229, allocations: 295.8 kB / 1.387 GB, free: 11.11 MB / 1.123 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003753/1.23, allocations: 214.8 kB / 1.387 GB, free: 10.9 MB / 1.123 GB
Notification: Performance of setup shared object (initialization): time 0.0001268/1.23, allocations: 345.9 kB / 1.387 GB, free: 10.55 MB / 1.123 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001163/1.231, allocations: 477.8 kB / 1.388 GB, free: 10.09 MB / 1.123 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0014/1.232, allocations: 0.7914 MB / 1.388 GB, free: 9.152 MB / 1.123 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002497/1.235, allocations: 1.258 MB / 1.39 GB, free: 7.77 MB / 1.123 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.474e-06/1.235, allocations: 0 / 1.39 GB, free: 7.77 MB / 1.123 GB
Notification: Performance of matching and sorting (n=133) (initialization): time 0.003374/1.238, allocations: 1.465 MB / 1.391 GB, free: 6.289 MB / 1.123 GB
Notification: Performance of prepare postOptimizeDAE: time 4.858e-05/1.238, allocations: 41.69 kB / 1.391 GB, free: 6.242 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.854e-05/1.238, allocations: 11.98 kB / 1.391 GB, free: 6.23 MB / 1.123 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.046e-05/1.238, allocations: 12 kB / 1.391 GB, free: 6.219 MB / 1.123 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0012/1.24, allocations: 284.2 kB / 1.391 GB, free: 5.941 MB / 1.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.868e-05/1.24, allocations: 23.94 kB / 1.391 GB, free: 5.918 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001477/1.241, allocations: 143.6 kB / 1.392 GB, free: 5.777 MB / 1.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001116/1.241, allocations: 51.98 kB / 1.392 GB, free: 5.727 MB / 1.123 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001759/1.243, allocations: 0.8304 MB / 1.392 GB, free: 4.895 MB / 1.123 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001316/1.244, allocations: 0.7718 MB / 1.393 GB, free: 3.98 MB / 1.123 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002371/1.247, allocations: 1.223 MB / 1.394 GB, free: 2.637 MB / 1.123 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.595e-06/1.247, allocations: 7.938 kB / 1.394 GB, free: 2.629 MB / 1.123 GB
Notification: Performance of matching and sorting (n=133) (initialization_lambda0): time 0.003209/1.25, allocations: 1.43 MB / 1.396 GB, free: 1.188 MB / 1.123 GB
Notification: Performance of prepare postOptimizeDAE: time 3.629e-05/1.25, allocations: 37.7 kB / 1.396 GB, free: 1.145 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.302e-05/1.25, allocations: 8.844 kB / 1.396 GB, free: 1.137 MB / 1.123 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.834e-05/1.25, allocations: 16 kB / 1.396 GB, free: 1.121 MB / 1.123 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001172/1.251, allocations: 275.6 kB / 1.396 GB, free: 0.8516 MB / 1.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.315e-05/1.251, allocations: 23.88 kB / 1.396 GB, free: 0.8281 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001417/1.253, allocations: 135.8 kB / 1.396 GB, free: 0.6953 MB / 1.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.665e-05/1.253, allocations: 47.98 kB / 1.396 GB, free: 0.6484 MB / 1.123 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 38
 * Number of states: 0 ()
 * Number of discrete variables: 6 (TSet.count,$PRE.TSet.count,TSet.T_start,$PRE.TSet.T_start,$whenCondition1,conPI.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (131):
 * Single equations (assignments): 129
 * Array equations: 1
 * Algorithm blocks: 1
 * 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.0003244/1.253, allocations: 254.6 kB / 1.396 GB, free: 404 kB / 1.123 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004054/1.254, allocations: 177.8 kB / 1.397 GB, free: 224 kB / 1.123 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002945/1.256, allocations: 1.204 MB / 1.398 GB, free: 15 MB / 1.139 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002335/1.259, allocations: 1.274 MB / 1.399 GB, free: 13.63 MB / 1.139 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.799e-06/1.259, allocations: 0 / 1.399 GB, free: 13.63 MB / 1.139 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007565/1.26, allocations: 350.5 kB / 1.399 GB, free: 13.27 MB / 1.139 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003139/1.26, allocations: 23.92 kB / 1.399 GB, free: 13.25 MB / 1.139 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001057/1.261, allocations: 67.94 kB / 1.399 GB, free: 13.18 MB / 1.139 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001514/1.261, allocations: 56.92 kB / 1.4 GB, free: 13.12 MB / 1.139 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.003309/1.264, allocations: 1.244 MB / 1.401 GB, free: 11.87 MB / 1.139 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003717/1.268, allocations: 1.852 MB / 1.403 GB, free: 10 MB / 1.139 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00109/1.269, allocations: 499.7 kB / 1.403 GB, free: 9.512 MB / 1.139 GB
Notification: Performance of sorting global known variables: time 0.001727/1.271, allocations: 1.053 MB / 1.404 GB, free: 8.469 MB / 1.139 GB
Notification: Performance of Backend: time 4.61e-07/1.271, allocations: 0 / 1.404 GB, free: 8.469 MB / 1.139 GB
Notification: Performance of simCode: created initialization part: time 0.007102/1.278, allocations: 2.515 MB / 1.407 GB, free: 6.098 MB / 1.139 GB
Notification: Performance of SimCode: time 0.007982/1.286, allocations: 4.284 MB / 1.411 GB, free: 1.773 MB / 1.139 GB
Notification: Performance of Templates: time 0.06616/1.352, allocations: 42.67 MB / 1.452 GB, free: 7.508 MB / 1.186 GB
make -j1 -f Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.makefile
(rm -f Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; mkfifo Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe >> ../files/Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.sim & ./Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_HeatExchangers_Examples_AirHeater_T.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_9_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches