Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.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/IDEAS 3.0.0-master/package.mo", uses=false) Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-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(IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T") translateModel(IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.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.001343/0.001343, allocations: 115.3 kB / 15.34 MB, free: 0.5156 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.00135/0.00135, allocations: 191.7 kB / 16.25 MB, free: 6.633 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.348/1.348, allocations: 222.9 MB / 239.9 MB, free: 4.551 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9154/0.9154, allocations: 135.6 MB / 425.6 MB, free: 12.01 MB / 350.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001893/0.001893, allocations: 68.19 kB / 0.5054 GB, free: 5.227 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1686/0.1706, allocations: 81.01 MB / 0.5845 GB, free: 4.352 MB / 494.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T): time 0.4863/0.6569, allocations: 233 MB / 0.8121 GB, free: 3.309 MB / 0.6231 GB Notification: Performance of NFInst.instExpressions: time 0.02346/0.6804, allocations: 15.62 MB / 0.8273 GB, free: 3.645 MB / 0.6387 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.00292/0.6834, allocations: 87.5 kB / 0.8274 GB, free: 3.559 MB / 0.6387 GB Notification: Performance of NFTyping.typeComponents: time 0.003872/0.6873, allocations: 1.181 MB / 0.8285 GB, free: 2.379 MB / 0.6387 GB Notification: Performance of NFTyping.typeBindings: time 0.008923/0.6962, allocations: 3.183 MB / 0.8317 GB, free: 15.19 MB / 0.6544 GB Notification: Performance of NFTyping.typeClassSections: time 0.006356/0.7026, allocations: 2.29 MB / 0.8339 GB, free: 12.91 MB / 0.6544 GB Notification: Performance of NFFlatten.flatten: time 0.007851/0.7104, allocations: 4.958 MB / 0.8387 GB, free: 7.941 MB / 0.6544 GB Notification: Performance of NFFlatten.resolveConnections: time 0.003473/0.7139, allocations: 1.89 MB / 0.8406 GB, free: 6.012 MB / 0.6544 GB Notification: Performance of NFEvalConstants.evaluate: time 0.00623/0.7202, allocations: 2.697 MB / 0.8432 GB, free: 3.305 MB / 0.6544 GB Notification: Performance of NFSimplifyModel.simplify: time 0.003501/0.7237, allocations: 1.664 MB / 0.8448 GB, free: 1.645 MB / 0.6544 GB Notification: Performance of NFPackage.collectConstants: time 0.0004872/0.7242, allocations: 200 kB / 0.845 GB, free: 1.449 MB / 0.6544 GB Notification: Performance of NFFlatten.collectFunctions: time 0.006447/0.7307, allocations: 3.539 MB / 0.8485 GB, free: 13.9 MB / 0.67 GB Notification: Performance of NFScalarize.scalarize: time 0.0008843/0.7316, allocations: 0.7556 MB / 0.8492 GB, free: 13.14 MB / 0.67 GB Notification: Performance of NFVerifyModel.verify: time 0.001494/0.7331, allocations: 1.205 MB / 0.8504 GB, free: 11.93 MB / 0.67 GB Notification: Performance of NFConvertDAE.convert: time 0.006267/0.7393, allocations: 4.452 MB / 0.8547 GB, free: 7.469 MB / 0.67 GB Notification: Performance of FrontEnd - DAE generated: time 5.961e-06/0.7394, allocations: 4 kB / 0.8547 GB, free: 7.465 MB / 0.67 GB Notification: Performance of FrontEnd: time 1.413e-06/0.7394, allocations: 3.938 kB / 0.8548 GB, free: 7.461 MB / 0.67 GB Notification: Performance of Transformations before backend: time 2.986e-05/0.7394, allocations: 0 / 0.8548 GB, free: 7.461 MB / 0.67 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.004707/0.7441, allocations: 2.844 MB / 0.8575 GB, free: 4.551 MB / 0.67 GB Notification: Performance of prepare preOptimizeDAE: time 3.67e-05/0.7442, allocations: 11.97 kB / 0.8575 GB, free: 4.539 MB / 0.67 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004584/0.7488, allocations: 0.7736 MB / 0.8583 GB, free: 3.762 MB / 0.67 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002936/0.7517, allocations: 1.652 MB / 0.8599 GB, free: 2.059 MB / 0.67 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003609/0.7521, allocations: 165.9 kB / 0.8601 GB, free: 1.898 MB / 0.67 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002253/0.7523, allocations: 143.9 kB / 0.8602 GB, free: 1.758 MB / 0.67 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003113/0.7554, allocations: 1.657 MB / 0.8618 GB, free: 32 kB / 0.67 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.148e-05/0.7555, allocations: 7.938 kB / 0.8618 GB, free: 24 kB / 0.67 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.2567/1.012, allocations: 55.52 kB / 0.8619 GB, free: 221.5 MB / 0.67 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 8.613e-05/1.012, allocations: 46.52 kB / 0.8619 GB, free: 221.5 MB / 0.67 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003345/1.016, allocations: 1.449 MB / 0.8633 GB, free: 221.5 MB / 0.67 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.008889/1.025, allocations: 7.553 MB / 0.8707 GB, free: 216.8 MB / 0.67 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002351/1.027, allocations: 1.587 MB / 0.8723 GB, free: 215.8 MB / 0.67 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0009677/1.028, allocations: 0.529 MB / 0.8728 GB, free: 215.6 MB / 0.67 GB Notification: Performance of preOpt evalFunc (simulation): time 0.001147/1.029, allocations: 0.775 MB / 0.8735 GB, free: 214.8 MB / 0.67 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001083/1.03, allocations: 0.565 MB / 0.8741 GB, free: 214.6 MB / 0.67 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.0007597/1.031, allocations: 88.31 kB / 0.8742 GB, free: 214.6 MB / 0.67 GB Notification: Performance of pre-optimization done (n=85): time 3.727e-06/1.031, allocations: 1.906 kB / 0.8742 GB, free: 214.6 MB / 0.67 GB Notification: Performance of matching and sorting (n=85): time 0.003552/1.034, allocations: 1.618 MB / 0.8758 GB, free: 214 MB / 0.67 GB Notification: Performance of inlineWhenForInitialization (initialization): time 3.532e-05/1.035, allocations: 64.78 kB / 0.8758 GB, free: 213.9 MB / 0.67 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001674/1.036, allocations: 1.568 MB / 0.8774 GB, free: 213.3 MB / 0.67 GB Notification: Performance of collectPreVariables (initialization): time 9.647e-05/1.036, allocations: 48.2 kB / 0.8774 GB, free: 213.3 MB / 0.67 GB Notification: Performance of collectInitialEqns (initialization): time 0.0005596/1.037, allocations: 0.9209 MB / 0.8783 GB, free: 212.6 MB / 0.67 GB Notification: Performance of collectInitialBindings (initialization): time 0.0002134/1.037, allocations: 306.7 kB / 0.8786 GB, free: 212.4 MB / 0.67 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002876/1.037, allocations: 210.3 kB / 0.8788 GB, free: 212.3 MB / 0.67 GB Notification: Performance of setup shared object (initialization): time 6.723e-05/1.037, allocations: 349.2 kB / 0.8791 GB, free: 211.9 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008793/1.038, allocations: 465 kB / 0.8796 GB, free: 211.8 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001003/1.039, allocations: 0.7931 MB / 0.8803 GB, free: 211.2 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.001882/1.041, allocations: 1.232 MB / 0.8815 GB, free: 210.6 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.201e-06/1.041, allocations: 3.344 kB / 0.8815 GB, free: 210.6 MB / 0.67 GB Notification: Performance of matching and sorting (n=135) (initialization): time 0.002631/1.044, allocations: 1.453 MB / 0.883 GB, free: 210 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 4.07e-05/1.044, allocations: 41.3 kB / 0.883 GB, free: 210 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.476e-05/1.044, allocations: 11.53 kB / 0.883 GB, free: 210 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.706e-05/1.044, allocations: 14.31 kB / 0.883 GB, free: 210 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001084/1.045, allocations: 276.2 kB / 0.8833 GB, free: 209.9 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.768e-05/1.045, allocations: 20.75 kB / 0.8833 GB, free: 209.9 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001531/1.047, allocations: 150.2 kB / 0.8835 GB, free: 209.9 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.422e-05/1.047, allocations: 52.45 kB / 0.8835 GB, free: 209.9 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001516/1.048, allocations: 0.8203 MB / 0.8843 GB, free: 209.5 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001023/1.049, allocations: 0.7797 MB / 0.8851 GB, free: 209 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001847/1.051, allocations: 1.21 MB / 0.8863 GB, free: 208.2 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.821e-06/1.051, allocations: 3.75 kB / 0.8863 GB, free: 208.2 MB / 0.67 GB Notification: Performance of matching and sorting (n=135) (initialization_lambda0): time 0.002534/1.054, allocations: 1.418 MB / 0.8876 GB, free: 207.7 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 3.203e-05/1.054, allocations: 40.7 kB / 0.8877 GB, free: 207.6 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.049e-05/1.054, allocations: 10.34 kB / 0.8877 GB, free: 207.6 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.386e-05/1.054, allocations: 12.75 kB / 0.8877 GB, free: 207.6 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001048/1.055, allocations: 272.2 kB / 0.888 GB, free: 207.6 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.682e-05/1.055, allocations: 21.25 kB / 0.888 GB, free: 207.6 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001511/1.056, allocations: 157.1 kB / 0.8881 GB, free: 207.6 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.855e-05/1.057, allocations: 52.53 kB / 0.8882 GB, free: 207.6 MB / 0.67 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 (133): * Single equations (assignments): 131 * 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.0003042/1.057, allocations: 246.5 kB / 0.8884 GB, free: 207.3 MB / 0.67 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002042/1.057, allocations: 178.5 kB / 0.8886 GB, free: 207.2 MB / 0.67 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002479/1.06, allocations: 1.197 MB / 0.8898 GB, free: 206.8 MB / 0.67 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.446e-06/1.06, allocations: 12.28 kB / 0.8898 GB, free: 206.8 MB / 0.67 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 8.396e-06/1.06, allocations: 5.562 kB / 0.8898 GB, free: 206.8 MB / 0.67 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001882/1.061, allocations: 1.256 MB / 0.891 GB, free: 206 MB / 0.67 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.004622/1.066, allocations: 2.921 MB / 0.8939 GB, free: 204.6 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.422e-06/1.066, allocations: 3.406 kB / 0.8939 GB, free: 204.6 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0009013/1.067, allocations: 189.3 kB / 0.894 GB, free: 204.6 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0002091/1.067, allocations: 54.67 kB / 0.8941 GB, free: 204.6 MB / 0.67 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.354e-05/1.067, allocations: 23.86 kB / 0.8941 GB, free: 204.6 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0009792/1.068, allocations: 1.53 MB / 0.8956 GB, free: 203.1 MB / 0.67 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.186e-06/1.068, allocations: 5.25 kB / 0.8956 GB, free: 203.1 MB / 0.67 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003621/1.072, allocations: 1.804 MB / 0.8974 GB, free: 202.3 MB / 0.67 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0008148/1.073, allocations: 335.1 kB / 0.8977 GB, free: 202 MB / 0.67 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001996/1.073, allocations: 23.3 kB / 0.8977 GB, free: 202 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001206/1.074, allocations: 132.9 kB / 0.8978 GB, free: 202 MB / 0.67 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001671/1.074, allocations: 66.39 kB / 0.8979 GB, free: 202 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.663e-05/1.074, allocations: 31.48 kB / 0.8979 GB, free: 202 MB / 0.67 GB Notification: Performance of sorting global known variables: time 0.001554/1.076, allocations: 1.053 MB / 0.899 GB, free: 201.6 MB / 0.67 GB Notification: Performance of sort global known variables: time 1.6e-07/1.076, allocations: 3.938 kB / 0.899 GB, free: 201.6 MB / 0.67 GB Notification: Performance of remove unused functions: time 0.002879/1.079, allocations: 0.96 MB / 0.8999 GB, free: 201.4 MB / 0.67 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.s[1],mov.filter.s[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 (86): * Single equations (assignments): 83 * 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.001933/1.081, allocations: 0.6009 MB / 0.9005 GB, free: 201.2 MB / 0.67 GB Notification: Performance of simCode: created initialization part: time 0.004322/1.085, allocations: 1.96 MB / 0.9024 GB, free: 200.6 MB / 0.67 GB Notification: Performance of simCode: created event and clocks part: time 5.781e-06/1.085, allocations: 0 / 0.9024 GB, free: 200.6 MB / 0.67 GB Notification: Performance of simCode: created simulation system equations: time 0.001256/1.086, allocations: 0.6238 MB / 0.903 GB, free: 200.3 MB / 0.67 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003694/1.09, allocations: 0.8219 MB / 0.9038 GB, free: 200 MB / 0.67 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.009238/1.099, allocations: 4.497 MB / 0.9082 GB, free: 197.5 MB / 0.67 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001489/1.101, allocations: 1.49 MB / 0.9097 GB, free: 196.6 MB / 0.67 GB Notification: Performance of simCode: alias equations: time 0.002531/1.103, allocations: 452.7 kB / 0.9101 GB, free: 196.5 MB / 0.67 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005304/1.104, allocations: 132.4 kB / 0.9102 GB, free: 196.5 MB / 0.67 GB Notification: Performance of SimCode: time 8.51e-07/1.104, allocations: 0 / 0.9102 GB, free: 196.5 MB / 0.67 GB Notification: Performance of Templates: time 0.06127/1.165, allocations: 31.45 MB / 0.9409 GB, free: 184.7 MB / 0.67 GB make -j1 -f IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T.makefile (rm -f IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T.sim & ./IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T.pipe 2>&1)