Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.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.Examples.Performance.Example1v2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2") translateModel(IDEAS.Fluid.Examples.Performance.Example1v2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001309/0.001309, allocations: 105.7 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.001189/0.001189, allocations: 189.8 kB / 17.2 MB, free: 5.953 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.315/1.315, allocations: 222.9 MB / 240.9 MB, free: 15.22 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8028/0.8028, allocations: 135.2 MB / 426.2 MB, free: 4.168 MB / 334.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001888/0.001888, allocations: 63.91 kB / 0.506 GB, free: 8.363 MB / 430.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.359/0.3609, allocations: 80.91 MB / 0.5851 GB, free: 25.2 MB / 446.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Examples.Performance.Example1v2): time 0.07395/0.4349, allocations: 80.61 MB / 0.6638 GB, free: 9.723 MB / 0.4981 GB Notification: Performance of NFInst.instExpressions: time 0.0304/0.4654, allocations: 19.24 MB / 0.6826 GB, free: 6.441 MB / 0.5137 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.004262/0.4697, allocations: 107.4 kB / 0.6827 GB, free: 6.336 MB / 0.5137 GB Notification: Performance of NFTyping.typeComponents: time 0.003848/0.4736, allocations: 1.153 MB / 0.6838 GB, free: 5.176 MB / 0.5137 GB Notification: Performance of NFTyping.typeBindings: time 0.008362/0.482, allocations: 2.761 MB / 0.6865 GB, free: 2.402 MB / 0.5137 GB Notification: Performance of NFTyping.typeClassSections: time 0.006693/0.4887, allocations: 2.374 MB / 0.6888 GB, free: 48 kB / 0.5137 GB Notification: Performance of NFFlatten.flatten: time 0.03084/0.5196, allocations: 26.83 MB / 0.715 GB, free: 5.148 MB / 0.545 GB Notification: Performance of NFFlatten.resolveConnections: time 0.02457/0.5442, allocations: 17.04 MB / 0.7316 GB, free: 3.988 MB / 0.5606 GB Notification: Performance of NFEvalConstants.evaluate: time 0.02389/0.5681, allocations: 11.24 MB / 0.7426 GB, free: 8.785 MB / 0.5762 GB Notification: Performance of NFSimplifyModel.simplify: time 0.578/1.146, allocations: 11.68 MB / 0.754 GB, free: 34.09 MB / 0.5763 GB Notification: Performance of NFPackage.collectConstants: time 0.005348/1.152, allocations: 1.282 MB / 0.7553 GB, free: 34.09 MB / 0.5763 GB Notification: Performance of NFFlatten.collectFunctions: time 0.0106/1.162, allocations: 2.569 MB / 0.7578 GB, free: 34.09 MB / 0.5763 GB Notification: Performance of NFScalarize.scalarize: time 0.007587/1.17, allocations: 3.631 MB / 0.7613 GB, free: 34.09 MB / 0.5763 GB Notification: Performance of NFVerifyModel.verify: time 0.0164/1.186, allocations: 6.491 MB / 0.7677 GB, free: 34.09 MB / 0.5763 GB Notification: Performance of NFConvertDAE.convert: time 0.02394/1.21, allocations: 18.32 MB / 0.7856 GB, free: 32.68 MB / 0.5763 GB Notification: Performance of FrontEnd - DAE generated: time 8.406e-06/1.21, allocations: 0 / 0.7856 GB, free: 32.68 MB / 0.5763 GB Notification: Performance of FrontEnd: time 1.913e-06/1.21, allocations: 0 / 0.7856 GB, free: 32.68 MB / 0.5763 GB Notification: Performance of Transformations before backend: time 0.0005036/1.211, allocations: 0 / 0.7856 GB, free: 32.68 MB / 0.5763 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1418 * Number of variables: 1418 Notification: Performance of Generate backend data structure: time 0.03716/1.248, allocations: 12.21 MB / 0.7975 GB, free: 28.59 MB / 0.5763 GB Notification: Performance of prepare preOptimizeDAE: time 3.848e-05/1.248, allocations: 8.953 kB / 0.7975 GB, free: 28.59 MB / 0.5763 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009089/1.257, allocations: 1.266 MB / 0.7987 GB, free: 27.99 MB / 0.5763 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0194/1.277, allocations: 9.653 MB / 0.8082 GB, free: 24.62 MB / 0.5763 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004077/1.277, allocations: 443.9 kB / 0.8086 GB, free: 24.61 MB / 0.5763 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.003949/1.281, allocations: 0.58 MB / 0.8092 GB, free: 24.6 MB / 0.5763 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.03096/1.312, allocations: 14.62 MB / 0.8234 GB, free: 18.95 MB / 0.5763 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0002388/1.312, allocations: 20.23 kB / 0.8234 GB, free: 18.95 MB / 0.5763 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.003489/1.316, allocations: 239.7 kB / 0.8237 GB, free: 18.77 MB / 0.5763 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.177e-05/1.316, allocations: 142 kB / 0.8238 GB, free: 18.77 MB / 0.5763 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02876/1.345, allocations: 19.76 MB / 0.8431 GB, free: 2.945 MB / 0.5763 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.1164/1.461, allocations: 60.25 MB / 0.902 GB, free: 6.008 MB / 0.6388 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01576/1.477, allocations: 9.163 MB / 0.9109 GB, free: 12.84 MB / 0.6544 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.01404/1.491, allocations: 8.588 MB / 0.9193 GB, free: 4.262 MB / 0.6544 GB Notification: Performance of preOpt evalFunc (simulation): time 0.05668/1.548, allocations: 27.45 MB / 0.9461 GB, free: 8.539 MB / 0.6857 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01296/1.561, allocations: 7.646 MB / 0.9536 GB, free: 0.8516 MB / 0.6857 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.01659/1.577, allocations: 4.488 MB / 0.9579 GB, free: 12.51 MB / 0.7013 GB Notification: Performance of pre-optimization done (n=299): time 2.006e-05/1.577, allocations: 0 / 0.9579 GB, free: 12.51 MB / 0.7013 GB Notification: Performance of matching and sorting (n=299): time 0.05378/1.631, allocations: 23.31 MB / 0.9807 GB, free: 5.117 MB / 0.7169 GB Notification: Performance of inlineWhenForInitialization (initialization): time 8.288e-05/1.631, allocations: 81.77 kB / 0.9808 GB, free: 5.023 MB / 0.7169 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01492/1.646, allocations: 8.25 MB / 0.9888 GB, free: 12.8 MB / 0.7325 GB Notification: Performance of collectPreVariables (initialization): time 0.002089/1.648, allocations: 97.7 kB / 0.9889 GB, free: 12.7 MB / 0.7325 GB Notification: Performance of collectInitialEqns (initialization): time 0.005006/1.653, allocations: 4.067 MB / 0.9929 GB, free: 8.617 MB / 0.7325 GB Notification: Performance of collectInitialBindings (initialization): time 0.003279/1.657, allocations: 1.067 MB / 0.994 GB, free: 7.559 MB / 0.7325 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.004508/1.661, allocations: 1.669 MB / 0.9956 GB, free: 5.875 MB / 0.7325 GB Notification: Performance of setup shared object (initialization): time 0.0001407/1.661, allocations: 301.1 kB / 0.9959 GB, free: 5.578 MB / 0.7325 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.01129/1.673, allocations: 6.547 MB / 1.002 GB, free: 15.01 MB / 0.7482 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01378/1.686, allocations: 8.33 MB / 1.01 GB, free: 5.871 MB / 0.7482 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.02665/1.713, allocations: 15.24 MB / 1.025 GB, free: 6.121 MB / 0.7638 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.972e-05/1.713, allocations: 16 kB / 1.025 GB, free: 6.105 MB / 0.7638 GB Notification: Performance of matching and sorting (n=578) (initialization): time 0.3172/2.03, allocations: 17.57 MB / 1.042 GB, free: 311.6 MB / 0.7638 GB Notification: Performance of prepare postOptimizeDAE: time 7.448e-05/2.031, allocations: 52.61 kB / 1.043 GB, free: 311.6 MB / 0.7638 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.303e-05/2.031, allocations: 47.69 kB / 1.043 GB, free: 311.6 MB / 0.7638 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.06603/2.097, allocations: 11.59 MB / 1.054 GB, free: 310.8 MB / 0.7638 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007985/2.105, allocations: 1.549 MB / 1.055 GB, free: 310.7 MB / 0.7638 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0048/2.11, allocations: 3.783 MB / 1.059 GB, free: 308.6 MB / 0.7638 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009728/2.119, allocations: 339.7 kB / 1.059 GB, free: 308.5 MB / 0.7638 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002712/2.122, allocations: 0.5434 MB / 1.06 GB, free: 308.5 MB / 0.7638 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01376/2.136, allocations: 8.821 MB / 1.069 GB, free: 304.9 MB / 0.7638 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.009701/2.146, allocations: 8.27 MB / 1.077 GB, free: 296.8 MB / 0.7638 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0187/2.164, allocations: 15.15 MB / 1.091 GB, free: 280.9 MB / 0.7638 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.949e-05/2.164, allocations: 12 kB / 1.091 GB, free: 280.9 MB / 0.7638 GB Notification: Performance of matching and sorting (n=578) (initialization_lambda0): time 0.02908/2.193, allocations: 17.41 MB / 1.108 GB, free: 263.8 MB / 0.7638 GB Notification: Performance of prepare postOptimizeDAE: time 5.524e-05/2.194, allocations: 53.7 kB / 1.108 GB, free: 263.7 MB / 0.7638 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.736e-05/2.194, allocations: 48 kB / 1.109 GB, free: 263.7 MB / 0.7638 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.06244/2.256, allocations: 11.14 MB / 1.119 GB, free: 252.6 MB / 0.7638 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007701/2.264, allocations: 1.549 MB / 1.121 GB, free: 251 MB / 0.7638 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008109/2.272, allocations: 8.174 MB / 1.129 GB, free: 242.6 MB / 0.7638 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009655/2.282, allocations: 339 kB / 1.129 GB, free: 242.3 MB / 0.7638 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002323/2.284, allocations: 0.5382 MB / 1.13 GB, free: 241.8 MB / 0.7638 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 217 * Number of states: 0 () * Number of discrete variables: 8 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,from_dp.y,nRes.y,allowFlowReversal.y) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (524): * Single equations (assignments): 519 * Array equations: 1 * Algorithm blocks: 1 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 3 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 3 systems {(2,5), (20,21), (2,5)} Notification: Performance of prepare postOptimizeDAE: time 0.00255/2.287, allocations: 493.3 kB / 1.13 GB, free: 241.3 MB / 0.7638 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.003016/2.29, allocations: 0.7683 MB / 1.131 GB, free: 240.7 MB / 0.7638 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02516/2.315, allocations: 14.18 MB / 1.145 GB, free: 226.5 MB / 0.7638 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.515e-05/2.315, allocations: 35.98 kB / 1.145 GB, free: 226.5 MB / 0.7638 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.423e-06/2.315, allocations: 0 / 1.145 GB, free: 226.5 MB / 0.7638 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01419/2.329, allocations: 10.79 MB / 1.155 GB, free: 215.6 MB / 0.7638 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03432/2.363, allocations: 24.56 MB / 1.179 GB, free: 191 MB / 0.7638 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.737e-05/2.363, allocations: 3.984 kB / 1.179 GB, free: 191 MB / 0.7638 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.005037/2.368, allocations: 0.6885 MB / 1.18 GB, free: 190.3 MB / 0.7638 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.05973/2.428, allocations: 10.74 MB / 1.191 GB, free: 179.6 MB / 0.7638 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001237/2.43, allocations: 103.9 kB / 1.191 GB, free: 179.5 MB / 0.7638 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00318/2.433, allocations: 3.115 MB / 1.194 GB, free: 176.3 MB / 0.7638 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.046e-06/2.433, allocations: 3.984 kB / 1.194 GB, free: 176.3 MB / 0.7638 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02429/2.457, allocations: 19.18 MB / 1.212 GB, free: 157.1 MB / 0.7638 GB Notification: Performance of postOpt removeConstants (simulation): time 0.00505/2.462, allocations: 1.813 MB / 1.214 GB, free: 155.2 MB / 0.7638 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.002349/2.464, allocations: 76.11 kB / 1.214 GB, free: 155.2 MB / 0.7638 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005984/2.47, allocations: 205.3 kB / 1.214 GB, free: 155 MB / 0.7638 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001051/2.472, allocations: 210.5 kB / 1.215 GB, free: 154.8 MB / 0.7638 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006109/2.472, allocations: 167.8 kB / 1.215 GB, free: 154.6 MB / 0.7638 GB Notification: Performance of sorting global known variables: time 0.008373/2.481, allocations: 5.691 MB / 1.22 GB, free: 148.9 MB / 0.7638 GB Notification: Performance of sort global known variables: time 3.21e-07/2.481, allocations: 0 / 1.22 GB, free: 148.9 MB / 0.7638 GB Notification: Performance of remove unused functions: time 0.01818/2.499, allocations: 4.777 MB / 1.225 GB, free: 144.4 MB / 0.7638 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 22 (pump.vol.dynBal.U,hea.outCon.T,vol[1].dynBal.U,vol[2].dynBal.U,vol[3].dynBal.U,vol[4].dynBal.U,vol[5].dynBal.U,vol[6].dynBal.U,vol[7].dynBal.U,vol[8].dynBal.U,vol[9].dynBal.U,vol[10].dynBal.U,vol[11].dynBal.U,vol[12].dynBal.U,vol[13].dynBal.U,vol[14].dynBal.U,vol[15].dynBal.U,vol[16].dynBal.U,vol[17].dynBal.U,vol[18].dynBal.U,vol[19].dynBal.U,vol[20].dynBal.U) * Number of discrete variables: 3 ($whenCondition1,pulse.T_start,pulse.count) * Number of discrete states: 1 (pulse.count) * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (301): * Single equations (assignments): 292 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 4 * When equations: 2 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 3 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 3 systems {(3,4), (2,5), (20,21)} Notification: Performance of Backend phase and start with SimCode phase: time 0.002565/2.501, allocations: 0.603 MB / 1.226 GB, free: 143.9 MB / 0.7638 GB Notification: Performance of simCode: created initialization part: time 0.04535/2.547, allocations: 29.15 MB / 1.254 GB, free: 114.6 MB / 0.7638 GB Notification: Performance of simCode: created event and clocks part: time 1.275e-05/2.547, allocations: 8.25 kB / 1.254 GB, free: 114.6 MB / 0.7638 GB Notification: Performance of simCode: created simulation system equations: time 0.009566/2.556, allocations: 6.327 MB / 1.26 GB, free: 108.3 MB / 0.7638 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02495/2.581, allocations: 4.917 MB / 1.265 GB, free: 103.6 MB / 0.7638 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03262/2.614, allocations: 20.76 MB / 1.285 GB, free: 82.87 MB / 0.7638 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.004143/2.618, allocations: 5.227 MB / 1.29 GB, free: 77.61 MB / 0.7638 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.005569/2.624, allocations: 0.9476 MB / 1.291 GB, free: 76.66 MB / 0.7638 GB Notification: Performance of SimCode: time 7.31e-07/2.624, allocations: 0 / 1.291 GB, free: 76.66 MB / 0.7638 GB Notification: Performance of Templates: time 0.5932/3.217, allocations: 308.1 MB / 1.592 GB, free: 87.42 MB / 0.7638 GB make -j1 -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.makefile (rm -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.sim & ./IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2 -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v2.pipe 2>&1)