Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 7.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo)
Running command: translateModel(Buildings.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T")
translateModel(Buildings.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo): time 1.395/1.395, allocations: 252 MB / 268 MB, free: 10.86 MB / 218.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.0009787/0.0009789, allocations: 181.9 kB / 327.6 MB, free: 2.09 MB / 250.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.686/1.686, allocations: 205.4 MB / 0.5786 GB, free: 20.08 MB / 426.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0008939/0.0008939, allocations: 82.36 kB / 0.6832 GB, free: 12.75 MB / 0.5105 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003523/0.0003523, allocations: 10.97 kB / 0.7976 GB, free: 135.2 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2567/0.2571, allocations: 106.3 MB / 0.9015 GB, free: 63.48 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.HeatExchangers.Examples.AirHeater_T): time 0.8309/1.088, allocations: 231 MB / 1.127 GB, free: 0.9219 MB / 0.698 GB
Notification: Performance of NFInst.instExpressions: time 0.02639/1.114, allocations: 18.65 MB / 1.145 GB, free: 456 kB / 0.698 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004877/1.119, allocations: 75.5 kB / 1.145 GB, free: 452 kB / 0.698 GB
Notification: Performance of NFTyping.typeComponents: time 0.00571/1.125, allocations: 1.179 MB / 1.146 GB, free: 412 kB / 0.698 GB
Notification: Performance of NFTyping.typeBindings: time 0.01133/1.136, allocations: 3.232 MB / 1.15 GB, free: 244 kB / 0.698 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01175/1.148, allocations: 3.316 MB / 1.153 GB, free: 124 kB / 0.698 GB
Notification: Performance of NFFlatten.flatten: time 0.0108/1.159, allocations: 6.657 MB / 1.159 GB, free: 15.12 MB / 0.7136 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004631/1.164, allocations: 1.616 MB / 1.161 GB, free: 14.21 MB / 0.7136 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007393/1.171, allocations: 2.309 MB / 1.163 GB, free: 13.41 MB / 0.7136 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004483/1.176, allocations: 1.601 MB / 1.165 GB, free: 12.69 MB / 0.7136 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007837/1.176, allocations: 81.66 kB / 1.165 GB, free: 12.69 MB / 0.7136 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.009514/1.186, allocations: 3.859 MB / 1.169 GB, free: 11.09 MB / 0.7136 GB
Notification: Performance of NFScalarize.scalarize: time 0.001584/1.188, allocations: 0.6577 MB / 1.169 GB, free: 10.68 MB / 0.7136 GB
Notification: Performance of NFVerifyModel.verify: time 0.003235/1.191, allocations: 1.097 MB / 1.17 GB, free: 9.984 MB / 0.7136 GB
Notification: Performance of NFConvertDAE.convert: time 0.006579/1.197, allocations: 3.281 MB / 1.173 GB, free: 8.059 MB / 0.7136 GB
Notification: Performance of FrontEnd - DAE generated: time 7.695e-06/1.198, allocations: 3.344 kB / 1.174 GB, free: 8.059 MB / 0.7136 GB
Notification: Performance of FrontEnd: time 3.416e-06/1.198, allocations: 0 / 1.174 GB, free: 8.059 MB / 0.7136 GB
Notification: Performance of Transformations before backend: time 0.0001694/1.198, allocations: 0 / 1.174 GB, free: 8.059 MB / 0.7136 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 336
 * Number of variables: 336
Notification: Performance of Generate backend data structure: time 0.006983/1.205, allocations: 2.477 MB / 1.176 GB, free: 6.254 MB / 0.7136 GB
Notification: Performance of prepare preOptimizeDAE: time 5.061e-05/1.205, allocations: 16.5 kB / 1.176 GB, free: 6.25 MB / 0.7136 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005225/1.21, allocations: 0.8022 MB / 1.177 GB, free: 5.898 MB / 0.7136 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.004712/1.215, allocations: 1.65 MB / 1.178 GB, free: 4.746 MB / 0.7136 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004663/1.215, allocations: 174.8 kB / 1.178 GB, free: 4.676 MB / 0.7136 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005262/1.216, allocations: 153.1 kB / 1.179 GB, free: 4.621 MB / 0.7136 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004365/1.22, allocations: 1.712 MB / 1.18 GB, free: 3.566 MB / 0.7136 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.185e-05/1.22, allocations: 2.344 kB / 1.18 GB, free: 3.566 MB / 0.7136 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.000211/1.22, allocations: 62.84 kB / 1.18 GB, free: 3.523 MB / 0.7136 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.301e-05/1.221, allocations: 58.22 kB / 1.18 GB, free: 3.508 MB / 0.7136 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004042/1.225, allocations: 1.5 MB / 1.182 GB, free: 2.371 MB / 0.7136 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.01325/1.238, allocations: 7.635 MB / 1.189 GB, free: 10.32 MB / 0.7292 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002878/1.241, allocations: 1.648 MB / 1.191 GB, free: 8.543 MB / 0.7292 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00113/1.242, allocations: 0.5377 MB / 1.191 GB, free: 8.008 MB / 0.7292 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001408/1.243, allocations: 0.8101 MB / 1.192 GB, free: 7.051 MB / 0.7292 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001307/1.245, allocations: 0.5894 MB / 1.193 GB, free: 6.453 MB / 0.7292 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001352/1.246, allocations: 127.2 kB / 1.193 GB, free: 6.328 MB / 0.7292 GB
Notification: Performance of pre-optimization done (n=84): time 4.849e-06/1.246, allocations: 0 / 1.193 GB, free: 6.328 MB / 0.7292 GB
Notification: Performance of matching and sorting (n=84): time 0.004747/1.251, allocations: 1.655 MB / 1.195 GB, free: 4.648 MB / 0.7292 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001089/1.251, allocations: 145.5 kB / 1.195 GB, free: 4.473 MB / 0.7292 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002531/1.253, allocations: 1.636 MB / 1.196 GB, free: 2.789 MB / 0.7292 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001341/1.254, allocations: 49.7 kB / 1.196 GB, free: 2.734 MB / 0.7292 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0009162/1.255, allocations: 0.9385 MB / 1.197 GB, free: 1.793 MB / 0.7292 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002894/1.255, allocations: 298.3 kB / 1.198 GB, free: 1.504 MB / 0.7292 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 8.556e-05/1.255, allocations: 24 kB / 1.198 GB, free: 1.48 MB / 0.7292 GB
Notification: Performance of setup shared object (initialization): time 0.000159/1.255, allocations: 345.9 kB / 1.198 GB, free: 1.137 MB / 0.7292 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001094/1.256, allocations: 490.3 kB / 1.198 GB, free: 0.6562 MB / 0.7292 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001404/1.258, allocations: 0.8507 MB / 1.199 GB, free: 15.66 MB / 0.7448 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002463/1.26, allocations: 1.29 MB / 1.2 GB, free: 14.28 MB / 0.7448 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.336e-06/1.26, allocations: 4 kB / 1.2 GB, free: 14.28 MB / 0.7448 GB
Notification: Performance of matching and sorting (n=138) (initialization): time 0.003225/1.263, allocations: 1.51 MB / 1.202 GB, free: 12.8 MB / 0.7448 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0002982/1.264, allocations: 381.2 kB / 1.202 GB, free: 12.31 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.254e-05/1.264, allocations: 8 kB / 1.202 GB, free: 12.3 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.921e-05/1.264, allocations: 16 kB / 1.202 GB, free: 12.29 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001169/1.265, allocations: 279.6 kB / 1.203 GB, free: 12.03 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.329e-05/1.265, allocations: 14.62 kB / 1.203 GB, free: 12.02 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00177/1.267, allocations: 168.3 kB / 1.203 GB, free: 11.86 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001093/1.267, allocations: 55.98 kB / 1.203 GB, free: 11.8 MB / 0.7448 GB
Notification: Performance of prepare postOptimizeDAE: time 1.194e-05/1.267, allocations: 4 kB / 1.203 GB, free: 11.8 MB / 0.7448 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002663/1.27, allocations: 1.307 MB / 1.204 GB, free: 10.54 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.64e-05/1.27, allocations: 8 kB / 1.204 GB, free: 10.53 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.368e-05/1.27, allocations: 12 kB / 1.204 GB, free: 10.52 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001087/1.271, allocations: 276 kB / 1.204 GB, free: 10.26 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.239e-05/1.271, allocations: 26.55 kB / 1.204 GB, free: 10.24 MB / 0.7448 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001718/1.272, allocations: 167.2 kB / 1.205 GB, free: 10.08 MB / 0.7448 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.918e-05/1.273, allocations: 55.98 kB / 1.205 GB, free: 10.02 MB / 0.7448 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 37
 * Number of states: 0 ()
 * Number of discrete variables: 6 ($whenCondition1,$PRE.TSet.T_start,TSet.T_start,$PRE.TSet.count,TSet.count,conPI.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (134):
 * Single equations (assignments): 130
 * Array equations: 2
 * Algorithm blocks: 1
 * Record equations: 1
 * 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.001187/1.274, allocations: 0.5431 MB / 1.205 GB, free: 9.488 MB / 0.7448 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002705/1.274, allocations: 185.6 kB / 1.205 GB, free: 9.305 MB / 0.7448 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002889/1.277, allocations: 1.208 MB / 1.207 GB, free: 8.082 MB / 0.7448 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.264e-05/1.277, allocations: 16 kB / 1.207 GB, free: 8.066 MB / 0.7448 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.824e-06/1.277, allocations: 1.5 kB / 1.207 GB, free: 8.066 MB / 0.7448 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002344/1.279, allocations: 1.281 MB / 1.208 GB, free: 6.699 MB / 0.7448 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.005762/1.285, allocations: 2.966 MB / 1.211 GB, free: 3.652 MB / 0.7448 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.513e-06/1.285, allocations: 8.125 kB / 1.211 GB, free: 3.645 MB / 0.7448 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001007/1.286, allocations: 197.9 kB / 1.211 GB, free: 3.457 MB / 0.7448 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0002556/1.286, allocations: 47.83 kB / 1.211 GB, free: 3.41 MB / 0.7448 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.074e-05/1.286, allocations: 27.98 kB / 1.211 GB, free: 3.383 MB / 0.7448 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001443/1.288, allocations: 1.423 MB / 1.212 GB, free: 1.836 MB / 0.7448 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.793e-06/1.288, allocations: 0 / 1.212 GB, free: 1.836 MB / 0.7448 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003878/1.292, allocations: 1.86 MB / 1.214 GB, free: 15.95 MB / 0.7605 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008232/1.293, allocations: 350.6 kB / 1.215 GB, free: 15.59 MB / 0.7605 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001912/1.293, allocations: 27.98 kB / 1.215 GB, free: 15.56 MB / 0.7605 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001232/1.294, allocations: 155.8 kB / 1.215 GB, free: 15.41 MB / 0.7605 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000153/1.294, allocations: 56.58 kB / 1.215 GB, free: 15.35 MB / 0.7605 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.654e-05/1.294, allocations: 35.92 kB / 1.215 GB, free: 15.32 MB / 0.7605 GB
Notification: Performance of sorting global known variables: time 0.00168/1.296, allocations: 1.113 MB / 1.216 GB, free: 14.18 MB / 0.7605 GB
Notification: Performance of sort global known variables: time 2.21e-07/1.296, allocations: 0 / 1.216 GB, free: 14.18 MB / 0.7605 GB
Notification: Performance of remove unused functions: time 0.002977/1.299, allocations: 1.001 MB / 1.217 GB, free: 13.18 MB / 0.7605 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 8 (vol.dynBal.U,vol.dynBal.m,vol.dynBal.mXi[1],mov.filter.x[1],mov.filter.x[2],conPI.I.y,THeaOut.T,hea.outCon.T)
 * Number of discrete variables: 3 ($whenCondition1,TSet.T_start,TSet.count)
 * Number of discrete states: 1 (TSet.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (84):
 * Single equations (assignments): 81
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.00159/1.301, allocations: 0.6385 MB / 1.217 GB, free: 12.68 MB / 0.7605 GB
Notification: Performance of simCode: created initialization part: time 0.004174/1.305, allocations: 1.955 MB / 1.219 GB, free: 10.73 MB / 0.7605 GB
Notification: Performance of simCode: created event and clocks part: time 4.589e-06/1.305, allocations: 0 / 1.219 GB, free: 10.73 MB / 0.7605 GB
Notification: Performance of simCode: created simulation system equations: time 0.001368/1.306, allocations: 0.6285 MB / 1.22 GB, free: 10.09 MB / 0.7605 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004225/1.31, allocations: 0.8171 MB / 1.221 GB, free: 9.273 MB / 0.7605 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008705/1.319, allocations: 4.678 MB / 1.225 GB, free: 4.547 MB / 0.7605 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001221/1.32, allocations: 1.507 MB / 1.227 GB, free: 3.008 MB / 0.7605 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006346/1.321, allocations: 143.4 kB / 1.227 GB, free: 2.867 MB / 0.7605 GB
Notification: Performance of SimCode: time 9.22e-07/1.321, allocations: 0 / 1.227 GB, free: 2.867 MB / 0.7605 GB
Notification: Performance of Templates: time 0.05794/1.379, allocations: 35.03 MB / 1.261 GB, free: 15.96 MB / 0.8073 GB
make -j1 -f Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.makefile
(rm -f Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; mkfifo Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; head -c 1048576 < Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe >> ../files/Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.sim & ./Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_maint.7.0.x_Buildings.Fluid.HeatExchangers.Examples.AirHeater_T.pipe 2>&1)