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.001461/0.001461, allocations: 111.3 kB / 15.23 MB, free: 0.6406 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.001508/0.001508, allocations: 195.2 kB / 16.14 MB, free: 6.719 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.369/1.369, allocations: 222.9 MB / 239.8 MB, free: 4.621 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9799/0.9799, allocations: 135.1 MB / 425.1 MB, free: 11.87 MB / 350.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001483/0.001483, allocations: 68.58 kB / 0.5047 GB, free: 5.781 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1781/0.1796, allocations: 80.92 MB / 0.5837 GB, free: 5.027 MB / 494.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatExchangers.Examples.AirHeater_T): time 0.6025/0.7821, allocations: 233.7 MB / 0.812 GB, free: 3.582 MB / 0.6231 GB Notification: Performance of NFInst.instExpressions: time 0.03023/0.8123, allocations: 15.88 MB / 0.8275 GB, free: 3.656 MB / 0.6387 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.005096/0.8176, allocations: 83.5 kB / 0.8275 GB, free: 3.574 MB / 0.6387 GB Notification: Performance of NFTyping.typeComponents: time 0.005402/0.823, allocations: 1.145 MB / 0.8287 GB, free: 2.426 MB / 0.6387 GB Notification: Performance of NFTyping.typeBindings: time 0.01246/0.8355, allocations: 3.176 MB / 0.8318 GB, free: 15.25 MB / 0.6544 GB Notification: Performance of NFTyping.typeClassSections: time 0.007749/0.8432, allocations: 2.237 MB / 0.8339 GB, free: 13.03 MB / 0.6544 GB Notification: Performance of NFFlatten.flatten: time 0.01019/0.8534, allocations: 6.531 MB / 0.8403 GB, free: 6.484 MB / 0.6544 GB Notification: Performance of NFFlatten.resolveConnections: time 0.004215/0.8577, allocations: 1.646 MB / 0.8419 GB, free: 4.793 MB / 0.6544 GB Notification: Performance of NFEvalConstants.evaluate: time 0.007519/0.8652, allocations: 2.412 MB / 0.8443 GB, free: 2.371 MB / 0.6544 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004481/0.8697, allocations: 1.608 MB / 0.8459 GB, free: 0.7617 MB / 0.6544 GB Notification: Performance of NFPackage.collectConstants: time 0.0008778/0.8706, allocations: 104 kB / 0.846 GB, free: 0.6602 MB / 0.6544 GB Notification: Performance of NFFlatten.collectFunctions: time 0.009093/0.8798, allocations: 3.761 MB / 0.8496 GB, free: 12.89 MB / 0.67 GB Notification: Performance of NFScalarize.scalarize: time 0.001588/0.8814, allocations: 0.6656 MB / 0.8503 GB, free: 12.22 MB / 0.67 GB Notification: Performance of NFVerifyModel.verify: time 0.003143/0.8845, allocations: 1.103 MB / 0.8514 GB, free: 11.11 MB / 0.67 GB Notification: Performance of NFConvertDAE.convert: time 0.01031/0.8949, allocations: 4.37 MB / 0.8556 GB, free: 6.73 MB / 0.67 GB Notification: Performance of FrontEnd - DAE generated: time 6.873e-06/0.8949, allocations: 0 / 0.8556 GB, free: 6.73 MB / 0.67 GB Notification: Performance of FrontEnd: time 1.854e-06/0.8949, allocations: 0 / 0.8556 GB, free: 6.73 MB / 0.67 GB Notification: Performance of Transformations before backend: time 0.0001435/0.8951, allocations: 0 / 0.8556 GB, free: 6.73 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.008824/0.9039, allocations: 2.83 MB / 0.8584 GB, free: 3.836 MB / 0.67 GB Notification: Performance of prepare preOptimizeDAE: time 5.347e-05/0.904, allocations: 8.031 kB / 0.8584 GB, free: 3.828 MB / 0.67 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00587/0.9099, allocations: 0.7775 MB / 0.8592 GB, free: 3.047 MB / 0.67 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004932/0.9148, allocations: 1.664 MB / 0.8608 GB, free: 1.332 MB / 0.67 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004245/0.9153, allocations: 170.5 kB / 0.8609 GB, free: 1.164 MB / 0.67 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0005121/0.9158, allocations: 139.9 kB / 0.8611 GB, free: 1.027 MB / 0.67 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.3812/1.297, allocations: 1.652 MB / 0.8627 GB, free: 222.2 MB / 0.67 GB Notification: Performance of preOpt findStateOrder (simulation): time 4.114e-05/1.297, allocations: 5.344 kB / 0.8627 GB, free: 222.2 MB / 0.67 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00014/1.297, allocations: 54.53 kB / 0.8627 GB, free: 222.2 MB / 0.67 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.572e-05/1.297, allocations: 48.92 kB / 0.8628 GB, free: 222.2 MB / 0.67 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003099/1.3, allocations: 1.45 MB / 0.8642 GB, free: 222.2 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.0096/1.31, allocations: 7.548 MB / 0.8716 GB, free: 217.2 MB / 0.67 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002371/1.312, allocations: 1.6 MB / 0.8731 GB, free: 216.2 MB / 0.67 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001011/1.313, allocations: 0.5209 MB / 0.8736 GB, free: 216 MB / 0.67 GB Notification: Performance of preOpt evalFunc (simulation): time 0.001237/1.315, allocations: 0.7739 MB / 0.8744 GB, free: 215.3 MB / 0.67 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001299/1.316, allocations: 0.5638 MB / 0.875 GB, free: 215.1 MB / 0.67 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.001479/1.318, allocations: 117.8 kB / 0.8751 GB, free: 215.1 MB / 0.67 GB Notification: Performance of pre-optimization done (n=85): time 4.488e-06/1.318, allocations: 3.562 kB / 0.8751 GB, free: 215.1 MB / 0.67 GB Notification: Performance of matching and sorting (n=85): time 0.004421/1.322, allocations: 1.604 MB / 0.8766 GB, free: 214.4 MB / 0.67 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.307e-05/1.322, allocations: 61.78 kB / 0.8767 GB, free: 214.4 MB / 0.67 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002326/1.324, allocations: 1.567 MB / 0.8782 GB, free: 213.8 MB / 0.67 GB Notification: Performance of collectPreVariables (initialization): time 0.000125/1.325, allocations: 48.95 kB / 0.8783 GB, free: 213.8 MB / 0.67 GB Notification: Performance of collectInitialEqns (initialization): time 0.000799/1.325, allocations: 0.9295 MB / 0.8792 GB, free: 213.1 MB / 0.67 GB Notification: Performance of collectInitialBindings (initialization): time 0.000243/1.326, allocations: 296.7 kB / 0.8795 GB, free: 212.8 MB / 0.67 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003126/1.326, allocations: 217.4 kB / 0.8797 GB, free: 212.7 MB / 0.67 GB Notification: Performance of setup shared object (initialization): time 9.128e-05/1.326, allocations: 350.8 kB / 0.88 GB, free: 212.4 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0009599/1.327, allocations: 457.3 kB / 0.8804 GB, free: 212.3 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001122/1.328, allocations: 0.7888 MB / 0.8812 GB, free: 211.7 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.001989/1.33, allocations: 1.236 MB / 0.8824 GB, free: 211 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.564e-06/1.33, allocations: 2.906 kB / 0.8824 GB, free: 211 MB / 0.67 GB Notification: Performance of matching and sorting (n=135) (initialization): time 0.00269/1.333, allocations: 1.438 MB / 0.8838 GB, free: 210.5 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 3.885e-05/1.333, allocations: 36.8 kB / 0.8839 GB, free: 210.4 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.558e-05/1.333, allocations: 16.97 kB / 0.8839 GB, free: 210.4 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.823e-05/1.333, allocations: 14.16 kB / 0.8839 GB, free: 210.4 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001082/1.334, allocations: 271.3 kB / 0.8842 GB, free: 210.4 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.026e-05/1.334, allocations: 22.56 kB / 0.8842 GB, free: 210.4 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001465/1.335, allocations: 149.1 kB / 0.8843 GB, free: 210.4 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.778e-05/1.336, allocations: 53.33 kB / 0.8844 GB, free: 210.4 MB / 0.67 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001492/1.337, allocations: 0.814 MB / 0.8852 GB, free: 210 MB / 0.67 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00106/1.338, allocations: 0.7699 MB / 0.8859 GB, free: 209.5 MB / 0.67 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001912/1.34, allocations: 1.201 MB / 0.8871 GB, free: 208.7 MB / 0.67 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.577e-06/1.34, allocations: 2.906 kB / 0.8871 GB, free: 208.7 MB / 0.67 GB Notification: Performance of matching and sorting (n=135) (initialization_lambda0): time 0.002499/1.343, allocations: 1.41 MB / 0.8885 GB, free: 208.1 MB / 0.67 GB Notification: Performance of prepare postOptimizeDAE: time 2.699e-05/1.343, allocations: 35.42 kB / 0.8885 GB, free: 208.1 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.729e-06/1.343, allocations: 9.219 kB / 0.8885 GB, free: 208.1 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.222e-05/1.343, allocations: 15.91 kB / 0.8885 GB, free: 208.1 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001054/1.344, allocations: 276.5 kB / 0.8888 GB, free: 208.1 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.562e-05/1.344, allocations: 17.69 kB / 0.8888 GB, free: 208.1 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001439/1.345, allocations: 159.2 kB / 0.889 GB, free: 208 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.513e-05/1.345, allocations: 49.47 kB / 0.889 GB, free: 208 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.0002666/1.346, allocations: 248.6 kB / 0.8892 GB, free: 207.8 MB / 0.67 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002118/1.346, allocations: 176.8 kB / 0.8894 GB, free: 207.7 MB / 0.67 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002491/1.348, allocations: 1.181 MB / 0.8906 GB, free: 207.2 MB / 0.67 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.136e-05/1.348, allocations: 10.92 kB / 0.8906 GB, free: 207.2 MB / 0.67 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.125e-05/1.348, allocations: 2.625 kB / 0.8906 GB, free: 207.2 MB / 0.67 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00199/1.35, allocations: 1.245 MB / 0.8918 GB, free: 206.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 postOpt removeSimpleEquations (simulation): time 0.004988/1.355, allocations: 2.939 MB / 0.8947 GB, free: 205.1 MB / 0.67 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.742e-06/1.355, allocations: 5.344 kB / 0.8947 GB, free: 205.1 MB / 0.67 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0009591/1.356, allocations: 184.7 kB / 0.8948 GB, free: 205.1 MB / 0.67 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0002333/1.357, allocations: 48.44 kB / 0.8949 GB, free: 205.1 MB / 0.67 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.321e-05/1.357, allocations: 26.67 kB / 0.8949 GB, free: 205.1 MB / 0.67 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0011/1.358, allocations: 1.419 MB / 0.8963 GB, free: 203.7 MB / 0.67 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.853e-06/1.358, allocations: 1.812 kB / 0.8963 GB, free: 203.7 MB / 0.67 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003616/1.361, allocations: 1.788 MB / 0.898 GB, free: 202.9 MB / 0.67 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0006256/1.362, allocations: 338 kB / 0.8984 GB, free: 202.7 MB / 0.67 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001921/1.362, allocations: 17.78 kB / 0.8984 GB, free: 202.6 MB / 0.67 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001183/1.363, allocations: 147.2 kB / 0.8985 GB, free: 202.6 MB / 0.67 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001633/1.364, allocations: 69.77 kB / 0.8986 GB, free: 202.6 MB / 0.67 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.633e-05/1.364, allocations: 30.23 kB / 0.8986 GB, free: 202.6 MB / 0.67 GB Notification: Performance of sorting global known variables: time 0.001663/1.365, allocations: 1.051 MB / 0.8996 GB, free: 202.2 MB / 0.67 GB Notification: Performance of sort global known variables: time 2.91e-07/1.365, allocations: 1.094 kB / 0.8996 GB, free: 202.2 MB / 0.67 GB Notification: Performance of remove unused functions: time 0.003101/1.368, allocations: 0.9666 MB / 0.9006 GB, free: 202 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 (85): * Single equations (assignments): 82 * 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.00161/1.37, allocations: 0.5919 MB / 0.9012 GB, free: 201.9 MB / 0.67 GB Notification: Performance of simCode: created initialization part: time 0.004025/1.374, allocations: 1.805 MB / 0.9029 GB, free: 201.2 MB / 0.67 GB Notification: Performance of simCode: created event and clocks part: time 5.089e-06/1.374, allocations: 3.938 kB / 0.9029 GB, free: 201.2 MB / 0.67 GB Notification: Performance of simCode: created simulation system equations: time 0.001318/1.375, allocations: 0.614 MB / 0.9035 GB, free: 200.9 MB / 0.67 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003691/1.379, allocations: 0.7793 MB / 0.9043 GB, free: 200.7 MB / 0.67 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008047/1.387, allocations: 4.371 MB / 0.9086 GB, free: 198.2 MB / 0.67 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001041/1.388, allocations: 1.488 MB / 0.91 GB, free: 197.4 MB / 0.67 GB Notification: Performance of simCode: alias equations: time 0.002352/1.391, allocations: 446.3 kB / 0.9104 GB, free: 197.3 MB / 0.67 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004163/1.391, allocations: 130.9 kB / 0.9106 GB, free: 197.3 MB / 0.67 GB Notification: Performance of SimCode: time 1.032e-06/1.391, allocations: 0 / 0.9106 GB, free: 197.3 MB / 0.67 GB Notification: Performance of Templates: time 0.0649/1.456, allocations: 30.53 MB / 0.9404 GB, free: 186.5 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)