Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.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/IBPSA 4.0.0-master/package.mo", uses=false) Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.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(IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T") translateModel(IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.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.001105/0.001105, allocations: 103.8 kB / 16.27 MB, free: 6.414 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.001116/0.001116, allocations: 188.9 kB / 17.2 MB, free: 5.949 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.276/1.276, allocations: 222.9 MB / 240.9 MB, free: 15.27 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7425/0.7425, allocations: 126.4 MB / 417.4 MB, free: 12.54 MB / 334.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001279/0.001279, allocations: 71.88 kB / 0.4953 GB, free: 3.117 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.2993/0.3006, allocations: 78.76 MB / 0.5723 GB, free: 31.25 MB / 446.1 MB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T): time 0.5042/0.8048, allocations: 236.4 MB / 0.8032 GB, free: 1.352 MB / 0.5762 GB Notification: Performance of NFInst.instExpressions: time 0.02108/0.8259, allocations: 17.54 MB / 0.8203 GB, free: 1.035 MB / 0.5762 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.003198/0.8291, allocations: 90.16 kB / 0.8204 GB, free: 1.035 MB / 0.5762 GB Notification: Performance of NFTyping.typeComponents: time 0.008151/0.8373, allocations: 4.612 MB / 0.8249 GB, free: 0.9531 MB / 0.5762 GB Notification: Performance of NFTyping.typeBindings: time 0.008141/0.8455, allocations: 3.427 MB / 0.8282 GB, free: 0.7969 MB / 0.5762 GB Notification: Performance of NFTyping.typeClassSections: time 0.005644/0.8511, allocations: 2.508 MB / 0.8307 GB, free: 0.7266 MB / 0.5762 GB Notification: Performance of NFFlatten.flatten: time 0.009834/0.861, allocations: 7.729 MB / 0.8382 GB, free: 14.55 MB / 0.5919 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002757/0.8637, allocations: 1.92 MB / 0.8401 GB, free: 13.38 MB / 0.5919 GB Notification: Performance of NFEvalConstants.evaluate: time 0.005842/0.8696, allocations: 2.795 MB / 0.8428 GB, free: 12.16 MB / 0.5919 GB Notification: Performance of NFSimplifyModel.simplify: time 0.003028/0.8727, allocations: 1.574 MB / 0.8444 GB, free: 11.38 MB / 0.5919 GB Notification: Performance of NFPackage.collectConstants: time 0.0004164/0.8731, allocations: 200.8 kB / 0.8445 GB, free: 11.38 MB / 0.5919 GB Notification: Performance of NFFlatten.collectFunctions: time 0.007061/0.8801, allocations: 3.59 MB / 0.8481 GB, free: 9.27 MB / 0.5919 GB Notification: Performance of NFScalarize.scalarize: time 0.001126/0.8813, allocations: 0.8766 MB / 0.8489 GB, free: 8.41 MB / 0.5919 GB Notification: Performance of NFVerifyModel.verify: time 0.002086/0.8834, allocations: 1.368 MB / 0.8502 GB, free: 7.059 MB / 0.5919 GB Notification: Performance of NFConvertDAE.convert: time 0.008357/0.8918, allocations: 4.828 MB / 0.855 GB, free: 2.473 MB / 0.5919 GB Notification: Performance of FrontEnd - DAE generated: time 4.509e-06/0.8918, allocations: 0 / 0.855 GB, free: 2.473 MB / 0.5919 GB Notification: Performance of FrontEnd: time 1.132e-06/0.8918, allocations: 0 / 0.855 GB, free: 2.473 MB / 0.5919 GB Notification: Performance of Transformations before backend: time 5.208e-05/0.8919, allocations: 0 / 0.855 GB, free: 2.473 MB / 0.5919 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 337 * Number of variables: 337 Notification: Performance of Generate backend data structure: time 0.005256/0.8971, allocations: 3.232 MB / 0.8581 GB, free: 15.2 MB / 0.6075 GB Notification: Performance of prepare preOptimizeDAE: time 3.356e-05/0.8972, allocations: 8.031 kB / 0.8581 GB, free: 15.19 MB / 0.6075 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005285/0.9025, allocations: 0.8818 MB / 0.859 GB, free: 14.3 MB / 0.6075 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004249/0.9067, allocations: 2.672 MB / 0.8616 GB, free: 11.64 MB / 0.6075 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003944/0.9071, allocations: 165 kB / 0.8617 GB, free: 11.48 MB / 0.6075 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.000227/0.9074, allocations: 147.9 kB / 0.8619 GB, free: 11.34 MB / 0.6075 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003148/0.9105, allocations: 1.675 MB / 0.8635 GB, free: 9.594 MB / 0.6075 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.933e-05/0.9106, allocations: 6.531 kB / 0.8635 GB, free: 9.59 MB / 0.6075 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001341/0.9107, allocations: 52 kB / 0.8636 GB, free: 9.539 MB / 0.6075 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.713e-05/0.9108, allocations: 46.52 kB / 0.8636 GB, free: 9.492 MB / 0.6075 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003459/0.9142, allocations: 1.469 MB / 0.8651 GB, free: 8.031 MB / 0.6075 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.01099/0.9252, allocations: 8.273 MB / 0.8731 GB, free: 15.3 MB / 0.6231 GB Notification: Performance of preOpt comSubExp (simulation): time 0.0027/0.928, allocations: 1.581 MB / 0.8747 GB, free: 13.59 MB / 0.6231 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001147/0.9291, allocations: 0.5336 MB / 0.8752 GB, free: 13.05 MB / 0.6231 GB Notification: Performance of preOpt evalFunc (simulation): time 0.001227/0.9304, allocations: 0.7684 MB / 0.876 GB, free: 12.14 MB / 0.6231 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001196/0.9316, allocations: 0.5494 MB / 0.8765 GB, free: 11.58 MB / 0.6231 GB Notification: Performance of pre-optimization done (n=82): time 3.166e-06/0.9316, allocations: 0 / 0.8765 GB, free: 11.58 MB / 0.6231 GB Notification: Performance of matching and sorting (n=82): time 0.004266/0.9359, allocations: 1.632 MB / 0.8781 GB, free: 9.918 MB / 0.6231 GB Notification: Performance of inlineWhenForInitialization (initialization): time 5.16e-05/0.9359, allocations: 60.06 kB / 0.8781 GB, free: 9.848 MB / 0.6231 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002706/0.9386, allocations: 2.136 MB / 0.8802 GB, free: 7.688 MB / 0.6231 GB Notification: Performance of collectPreVariables (initialization): time 0.0001136/0.9388, allocations: 49.7 kB / 0.8803 GB, free: 7.633 MB / 0.6231 GB Notification: Performance of collectInitialEqns (initialization): time 0.0008621/0.9396, allocations: 1.06 MB / 0.8813 GB, free: 6.566 MB / 0.6231 GB Notification: Performance of collectInitialBindings (initialization): time 0.0002557/0.9399, allocations: 293.5 kB / 0.8816 GB, free: 6.281 MB / 0.6231 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004317/0.9403, allocations: 318.5 kB / 0.8819 GB, free: 5.965 MB / 0.6231 GB Notification: Performance of setup shared object (initialization): time 8.642e-05/0.9404, allocations: 307.7 kB / 0.8822 GB, free: 5.664 MB / 0.6231 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.00129/0.9417, allocations: 0.6235 MB / 0.8828 GB, free: 5.035 MB / 0.6231 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001533/0.9433, allocations: 1.012 MB / 0.8838 GB, free: 3.875 MB / 0.6231 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.002777/0.9461, allocations: 1.571 MB / 0.8853 GB, free: 2.207 MB / 0.6231 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.442e-06/0.9461, allocations: 0 / 0.8853 GB, free: 2.207 MB / 0.6231 GB Notification: Performance of matching and sorting (n=199) (initialization): time 0.00388/0.95, allocations: 1.92 MB / 0.8872 GB, free: 340 kB / 0.6231 GB Notification: Performance of prepare postOptimizeDAE: time 6.173e-05/0.9501, allocations: 37.7 kB / 0.8872 GB, free: 296 kB / 0.6231 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.007e-05/0.9501, allocations: 10.62 kB / 0.8872 GB, free: 288 kB / 0.6231 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.72e-05/0.9501, allocations: 19.94 kB / 0.8873 GB, free: 268 kB / 0.6231 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001328/0.9515, allocations: 325.8 kB / 0.8876 GB, free: 15.96 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.891e-05/0.9515, allocations: 25.05 kB / 0.8876 GB, free: 15.94 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001797/0.9533, allocations: 187 kB / 0.8878 GB, free: 15.76 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001242/0.9534, allocations: 52 kB / 0.8878 GB, free: 15.71 MB / 0.6387 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002216/0.9557, allocations: 1.119 MB / 0.8889 GB, free: 14.59 MB / 0.6387 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001669/0.9574, allocations: 1.015 MB / 0.8899 GB, free: 13.43 MB / 0.6387 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002814/0.9602, allocations: 1.562 MB / 0.8914 GB, free: 11.76 MB / 0.6387 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.582e-06/0.9602, allocations: 4 kB / 0.8914 GB, free: 11.76 MB / 0.6387 GB Notification: Performance of matching and sorting (n=199) (initialization_lambda0): time 0.003891/0.9641, allocations: 1.918 MB / 0.8933 GB, free: 9.879 MB / 0.6387 GB Notification: Performance of prepare postOptimizeDAE: time 3.468e-05/0.9642, allocations: 36.23 kB / 0.8933 GB, free: 9.84 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.383e-05/0.9642, allocations: 12 kB / 0.8934 GB, free: 9.828 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.664e-05/0.9642, allocations: 16 kB / 0.8934 GB, free: 9.812 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001285/0.9655, allocations: 330.2 kB / 0.8937 GB, free: 9.508 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.141e-05/0.9655, allocations: 21.16 kB / 0.8937 GB, free: 9.492 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001786/0.9673, allocations: 172 kB / 0.8939 GB, free: 9.324 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001148/0.9674, allocations: 59.98 kB / 0.8939 GB, free: 9.266 MB / 0.6387 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 42 * 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 (165): * Single equations (assignments): 162 * Array equations: 1 * 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.0003202/0.9678, allocations: 262 kB / 0.8942 GB, free: 9.02 MB / 0.6387 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004898/0.9683, allocations: 215.8 kB / 0.8944 GB, free: 8.809 MB / 0.6387 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003188/0.9715, allocations: 1.187 MB / 0.8955 GB, free: 7.605 MB / 0.6387 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 9.879e-06/0.9715, allocations: 8 kB / 0.8956 GB, free: 7.598 MB / 0.6387 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.152e-05/0.9715, allocations: 7.938 kB / 0.8956 GB, free: 7.59 MB / 0.6387 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002453/0.974, allocations: 1.245 MB / 0.8968 GB, free: 6.262 MB / 0.6387 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.006634/0.9806, allocations: 3.117 MB / 0.8998 GB, free: 3.07 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.045e-06/0.9807, allocations: 11.88 kB / 0.8998 GB, free: 3.059 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001016/0.9817, allocations: 191.6 kB / 0.9 GB, free: 2.879 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0002256/0.9819, allocations: 48.83 kB / 0.9001 GB, free: 2.828 MB / 0.6387 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.079e-05/0.982, allocations: 23.98 kB / 0.9001 GB, free: 2.805 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001216/0.9832, allocations: 1.531 MB / 0.9016 GB, free: 1.141 MB / 0.6387 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.797e-06/0.9832, allocations: 4.031 kB / 0.9016 GB, free: 1.137 MB / 0.6387 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003886/0.9871, allocations: 1.779 MB / 0.9033 GB, free: 15.33 MB / 0.6544 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0008003/0.9879, allocations: 398.1 kB / 0.9037 GB, free: 14.92 MB / 0.6544 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003664/0.9883, allocations: 27.98 kB / 0.9037 GB, free: 14.89 MB / 0.6544 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00119/0.9895, allocations: 67.84 kB / 0.9038 GB, free: 14.83 MB / 0.6544 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001436/0.9897, allocations: 64.56 kB / 0.9038 GB, free: 14.77 MB / 0.6544 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.825e-05/0.9897, allocations: 30.52 kB / 0.9039 GB, free: 14.74 MB / 0.6544 GB Notification: Performance of sorting global known variables: time 0.002225/0.992, allocations: 1.425 MB / 0.9053 GB, free: 13.3 MB / 0.6544 GB Notification: Performance of sort global known variables: time 2.31e-07/0.992, allocations: 0 / 0.9053 GB, free: 13.3 MB / 0.6544 GB Notification: Performance of remove unused functions: time 0.002863/0.9949, allocations: 1.095 MB / 0.9063 GB, free: 12.2 MB / 0.6544 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 5 * Number of states: 8 (vol.dynBal.medium.Xi[1],vol.dynBal.U,vol.dynBal.m,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 (82): * Single equations (assignments): 79 * 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.001718/0.9966, allocations: 0.7252 MB / 0.907 GB, free: 11.68 MB / 0.6544 GB Notification: Performance of simCode: created initialization part: time 0.005185/1.002, allocations: 2.444 MB / 0.9094 GB, free: 9.285 MB / 0.6544 GB Notification: Performance of simCode: created event and clocks part: time 4.709e-06/1.002, allocations: 0 / 0.9094 GB, free: 9.285 MB / 0.6544 GB Notification: Performance of simCode: created simulation system equations: time 0.001343/1.003, allocations: 0.6181 MB / 0.91 GB, free: 8.672 MB / 0.6544 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00434/1.008, allocations: 1.018 MB / 0.911 GB, free: 7.711 MB / 0.6544 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.008238/1.016, allocations: 4.241 MB / 0.9152 GB, free: 3.434 MB / 0.6544 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001473/1.017, allocations: 1.661 MB / 0.9168 GB, free: 1.742 MB / 0.6544 GB Notification: Performance of simCode: alias equations: time 0.002373/1.02, allocations: 0.5558 MB / 0.9173 GB, free: 1.184 MB / 0.6544 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005305/1.02, allocations: 163.4 kB / 0.9175 GB, free: 1.023 MB / 0.6544 GB Notification: Performance of SimCode: time 1.733e-06/1.02, allocations: 0 / 0.9175 GB, free: 1.023 MB / 0.6544 GB Notification: Performance of Templates: time 0.06999/1.09, allocations: 38.98 MB / 0.9556 GB, free: 10.63 MB / 0.7012 GB make -j1 -f IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T.makefile (rm -f IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T.sim & ./IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.AirHeater_T.pipe 2>&1)