Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1.conf.json 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/IDEAS 3.0.0/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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 IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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) Running command: translateModel(IDEAS.Fluid.Examples.Performance.Example1v1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1") translateModel(IDEAS.Fluid.Examples.Performance.Example1v1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001718/0.001718, allocations: 182.1 kB / 15.98 MB, free: 5.77 MB / 13.93 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.7315/0.7315, allocations: 132.2 MB / 148.9 MB, free: 12.15 MB / 122.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.357/1.357, allocations: 222.9 MB / 403.3 MB, free: 7.113 MB / 314.7 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001001/0.001001, allocations: 99.73 kB / 484.3 MB, free: 8.715 MB / 394.7 MB Notification: Performance of FrontEnd - loaded program: time 0.0009735/0.0009735, allocations: 55.91 kB / 0.5618 GB, free: 71.07 MB / 426.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.115/0.116, allocations: 80.21 MB / 0.6402 GB, free: 6.789 MB / 442.7 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Examples.Performance.Example1v1): time 0.3286/0.4447, allocations: 71.81 MB / 0.7103 GB, free: 16.93 MB / 490.7 MB Notification: Performance of NFInst.instExpressions: time 0.02145/0.4662, allocations: 17.09 MB / 0.727 GB, free: 15.19 MB / 490.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.003485/0.4697, allocations: 82.66 kB / 0.7271 GB, free: 15.16 MB / 490.7 MB Notification: Performance of NFTyping.typeComponents: time 0.002562/0.4723, allocations: 0.8677 MB / 0.7279 GB, free: 14.76 MB / 490.7 MB Notification: Performance of NFTyping.typeBindings: time 0.006422/0.4788, allocations: 2.186 MB / 0.7301 GB, free: 13.67 MB / 490.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.004958/0.4837, allocations: 1.85 MB / 0.7319 GB, free: 12.64 MB / 490.7 MB Notification: Performance of NFFlatten.flatten: time 0.011/0.4948, allocations: 10.65 MB / 0.7423 GB, free: 8.105 MB / 490.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.006907/0.5017, allocations: 5.638 MB / 0.7478 GB, free: 4.418 MB / 490.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.006088/0.5078, allocations: 2.921 MB / 0.7506 GB, free: 2.84 MB / 490.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.00421/0.5121, allocations: 2.503 MB / 0.7531 GB, free: 1.359 MB / 490.7 MB Notification: Performance of NFPackage.collectConstants: time 0.0008745/0.5129, allocations: 164.4 kB / 0.7532 GB, free: 1.352 MB / 490.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.003848/0.5168, allocations: 1.259 MB / 0.7544 GB, free: 196 kB / 490.7 MB Notification: Performance of NFScalarize.scalarize: time 0.001149/0.518, allocations: 0.6611 MB / 0.7551 GB, free: 15.53 MB / 0.4948 GB Notification: Performance of NFVerifyModel.verify: time 0.00309/0.5211, allocations: 1.655 MB / 0.7567 GB, free: 13.86 MB / 0.4948 GB Notification: Performance of NFConvertDAE.convert: time 0.006225/0.5273, allocations: 4.587 MB / 0.7612 GB, free: 9.262 MB / 0.4948 GB Notification: Performance of FrontEnd - DAE generated: time 5.841e-06/0.5274, allocations: 7.938 kB / 0.7612 GB, free: 9.254 MB / 0.4948 GB Notification: Performance of FrontEnd: time 1.693e-06/0.5274, allocations: 0 / 0.7612 GB, free: 9.254 MB / 0.4948 GB Notification: Performance of Transformations before backend: time 0.0001522/0.5275, allocations: 0 / 0.7612 GB, free: 9.254 MB / 0.4948 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 398 * Number of variables: 398 Notification: Performance of Generate backend data structure: time 0.007177/0.5347, allocations: 3.955 MB / 0.7651 GB, free: 5.219 MB / 0.4948 GB Notification: Performance of prepare preOptimizeDAE: time 3.63e-05/0.5348, allocations: 8.031 kB / 0.7651 GB, free: 5.211 MB / 0.4948 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002066/0.5368, allocations: 0.55 MB / 0.7656 GB, free: 4.656 MB / 0.4948 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004665/0.5415, allocations: 2.643 MB / 0.7682 GB, free: 1.949 MB / 0.4948 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001275/0.5416, allocations: 139.8 kB / 0.7683 GB, free: 1.812 MB / 0.4948 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002601/0.5419, allocations: 183.9 kB / 0.7685 GB, free: 1.633 MB / 0.4948 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003394/0.5453, allocations: 2.315 MB / 0.7708 GB, free: 15.18 MB / 0.5105 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.54e-05/0.5454, allocations: 11.92 kB / 0.7708 GB, free: 15.17 MB / 0.5105 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001555/0.5455, allocations: 68 kB / 0.7708 GB, free: 15.1 MB / 0.5105 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.158e-05/0.5456, allocations: 40 kB / 0.7709 GB, free: 15.06 MB / 0.5105 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003293/0.5489, allocations: 1.876 MB / 0.7727 GB, free: 13.18 MB / 0.5105 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.01207/0.561, allocations: 11.23 MB / 0.7837 GB, free: 1.344 MB / 0.5105 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002608/0.5636, allocations: 1.344 MB / 0.785 GB, free: 15.99 MB / 0.5261 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001497/0.5651, allocations: 1.005 MB / 0.786 GB, free: 14.98 MB / 0.5261 GB Notification: Performance of preOpt evalFunc (simulation): time 0.005687/0.5708, allocations: 3.635 MB / 0.7895 GB, free: 11.08 MB / 0.5261 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001349/0.5722, allocations: 0.7779 MB / 0.7903 GB, free: 10.29 MB / 0.5261 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.001156/0.5733, allocations: 282.9 kB / 0.7905 GB, free: 10.01 MB / 0.5261 GB Notification: Performance of pre-optimization done (n=96): time 2.816e-06/0.5733, allocations: 0 / 0.7905 GB, free: 10.01 MB / 0.5261 GB Notification: Performance of matching and sorting (n=96): time 0.01162/0.585, allocations: 4.122 MB / 0.7946 GB, free: 5.84 MB / 0.5261 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.462e-05/0.585, allocations: 68.41 kB / 0.7946 GB, free: 5.762 MB / 0.5261 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003401/0.5884, allocations: 2.852 MB / 0.7974 GB, free: 2.91 MB / 0.5261 GB Notification: Performance of collectPreVariables (initialization): time 0.0001211/0.5886, allocations: 61.69 kB / 0.7975 GB, free: 2.844 MB / 0.5261 GB Notification: Performance of collectInitialEqns (initialization): time 0.001082/0.5897, allocations: 1.428 MB / 0.7989 GB, free: 1.398 MB / 0.5261 GB Notification: Performance of collectInitialBindings (initialization): time 0.0002634/0.5899, allocations: 339.2 kB / 0.7992 GB, free: 1.062 MB / 0.5261 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004513/0.5904, allocations: 331.7 kB / 0.7995 GB, free: 0.7305 MB / 0.5261 GB Notification: Performance of setup shared object (initialization): time 8.435e-05/0.5905, allocations: 305.1 kB / 0.7998 GB, free: 440 kB / 0.5261 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001231/0.5917, allocations: 0.6692 MB / 0.8005 GB, free: 15.76 MB / 0.5417 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001631/0.5934, allocations: 1.403 MB / 0.8018 GB, free: 14.02 MB / 0.5417 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.002686/0.5961, allocations: 1.862 MB / 0.8036 GB, free: 11.96 MB / 0.5417 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.154e-06/0.5961, allocations: 4 kB / 0.8037 GB, free: 11.95 MB / 0.5417 GB Notification: Performance of matching and sorting (n=181) (initialization): time 0.005383/0.6015, allocations: 2.804 MB / 0.8064 GB, free: 9.121 MB / 0.5417 GB Notification: Performance of prepare postOptimizeDAE: time 3.511e-05/0.6015, allocations: 41.69 kB / 0.8064 GB, free: 9.074 MB / 0.5417 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.435e-05/0.6015, allocations: 12 kB / 0.8064 GB, free: 9.062 MB / 0.5417 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.002419/0.604, allocations: 0.6926 MB / 0.8071 GB, free: 8.363 MB / 0.5417 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001104/0.6051, allocations: 289.4 kB / 0.8074 GB, free: 8.082 MB / 0.5417 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00167/0.6068, allocations: 1.892 MB / 0.8092 GB, free: 6.137 MB / 0.5417 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001761/0.6085, allocations: 172.8 kB / 0.8094 GB, free: 5.965 MB / 0.5417 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001317/0.6087, allocations: 87.89 kB / 0.8095 GB, free: 5.879 MB / 0.5417 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001949/0.6106, allocations: 1.262 MB / 0.8107 GB, free: 4.613 MB / 0.5417 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001453/0.6121, allocations: 1.358 MB / 0.812 GB, free: 2.914 MB / 0.5417 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002398/0.6145, allocations: 1.771 MB / 0.8138 GB, free: 0.9375 MB / 0.5417 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.432e-06/0.6145, allocations: 7.938 kB / 0.8138 GB, free: 0.9297 MB / 0.5417 GB Notification: Performance of matching and sorting (n=181) (initialization_lambda0): time 0.004061/0.6186, allocations: 2.638 MB / 0.8164 GB, free: 14.25 MB / 0.5573 GB Notification: Performance of prepare postOptimizeDAE: time 3.157e-05/0.6186, allocations: 38.64 kB / 0.8164 GB, free: 14.2 MB / 0.5573 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.39e-05/0.6187, allocations: 19.94 kB / 0.8164 GB, free: 14.18 MB / 0.5573 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0008598/0.6195, allocations: 473.8 kB / 0.8169 GB, free: 13.71 MB / 0.5573 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001039/0.6206, allocations: 281.4 kB / 0.8171 GB, free: 13.44 MB / 0.5573 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006039/0.6266, allocations: 5.842 MB / 0.8228 GB, free: 7.32 MB / 0.5573 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001635/0.6283, allocations: 193.3 kB / 0.823 GB, free: 7.133 MB / 0.5573 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001122/0.6284, allocations: 67.98 kB / 0.8231 GB, free: 7.066 MB / 0.5573 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 63 * 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 (133): * Single equations (assignments): 129 * Array equations: 1 * Algorithm blocks: 1 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * 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): 2 systems {(1,40), (2,5)} Notification: Performance of prepare postOptimizeDAE: time 0.0003164/0.6287, allocations: 286.5 kB / 0.8234 GB, free: 6.777 MB / 0.5573 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003214/0.6291, allocations: 300.2 kB / 0.8236 GB, free: 6.48 MB / 0.5573 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004252/0.6333, allocations: 2.281 MB / 0.8259 GB, free: 4.176 MB / 0.5573 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.194e-05/0.6333, allocations: 8 kB / 0.8259 GB, free: 4.168 MB / 0.5573 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.883e-06/0.6334, allocations: 3.938 kB / 0.8259 GB, free: 4.164 MB / 0.5573 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003137/0.6365, allocations: 1.983 MB / 0.8278 GB, free: 2.109 MB / 0.5573 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.006494/0.643, allocations: 4.332 MB / 0.8321 GB, free: 13.7 MB / 0.573 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.889e-06/0.643, allocations: 0 / 0.8321 GB, free: 13.7 MB / 0.573 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007391/0.6438, allocations: 157.2 kB / 0.8322 GB, free: 13.54 MB / 0.573 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.001012/0.6448, allocations: 480.8 kB / 0.8327 GB, free: 13.06 MB / 0.573 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.012e-05/0.6449, allocations: 23.98 kB / 0.8327 GB, free: 13.04 MB / 0.573 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00148/0.6464, allocations: 1.858 MB / 0.8345 GB, free: 11.13 MB / 0.573 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.373e-06/0.6464, allocations: 0 / 0.8345 GB, free: 11.13 MB / 0.573 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.164/0.8104, allocations: 44.14 MB / 0.8776 GB, free: 14.22 MB / 0.6198 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0007997/0.8112, allocations: 469.3 kB / 0.8781 GB, free: 13.74 MB / 0.6198 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002487/0.8115, allocations: 27.94 kB / 0.8781 GB, free: 13.71 MB / 0.6198 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0012/0.8127, allocations: 143.7 kB / 0.8782 GB, free: 13.57 MB / 0.6198 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001522/0.8128, allocations: 68.84 kB / 0.8783 GB, free: 13.51 MB / 0.6198 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.504e-05/0.8129, allocations: 35.98 kB / 0.8783 GB, free: 13.47 MB / 0.6198 GB Notification: Performance of sorting global known variables: time 0.002418/0.8153, allocations: 1.951 MB / 0.8802 GB, free: 11.53 MB / 0.6198 GB Notification: Performance of sort global known variables: time 1.4e-07/0.8154, allocations: 0 / 0.8802 GB, free: 11.53 MB / 0.6198 GB Notification: Performance of remove unused functions: time 0.007039/0.8224, allocations: 2.423 MB / 0.8826 GB, free: 9.102 MB / 0.6198 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 2 (pump.vol.dynBal.U,hea.outCon.T) * 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 (58): * Single equations (assignments): 50 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 4 * When equations: 2 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * 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): 2 systems {(2,5), (1,40)} Notification: Performance of Backend phase and start with SimCode phase: time 0.001171/0.8236, allocations: 0.5381 MB / 0.8831 GB, free: 8.562 MB / 0.6198 GB Notification: Performance of simCode: created initialization part: time 0.005265/0.8289, allocations: 3.11 MB / 0.8862 GB, free: 5.406 MB / 0.6198 GB Notification: Performance of simCode: created event and clocks part: time 3.267e-06/0.8289, allocations: 0 / 0.8862 GB, free: 5.406 MB / 0.6198 GB Notification: Performance of simCode: created simulation system equations: time 0.001405/0.8303, allocations: 0.7421 MB / 0.8869 GB, free: 4.668 MB / 0.6198 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004856/0.8352, allocations: 1.188 MB / 0.888 GB, free: 3.488 MB / 0.6198 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.009082/0.8442, allocations: 7.092 MB / 0.895 GB, free: 12.32 MB / 0.6355 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001439/0.8457, allocations: 2.091 MB / 0.897 GB, free: 10.2 MB / 0.6355 GB Notification: Performance of simCode: alias equations: time 0.003103/0.8488, allocations: 0.7886 MB / 0.8978 GB, free: 9.406 MB / 0.6355 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0007903/0.8496, allocations: 219.3 kB / 0.898 GB, free: 9.195 MB / 0.6355 GB Notification: Performance of SimCode: time 4.61e-07/0.8496, allocations: 0 / 0.898 GB, free: 9.195 MB / 0.6355 GB Notification: Performance of Templates: time 0.342/1.192, allocations: 67.33 MB / 0.9637 GB, free: 247.2 MB / 0.6823 GB make -j1 -f IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1.makefile (rm -f IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1.pipe ; mkfifo IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1.pipe >> ../files/IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1.sim & ./IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1 -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Examples.Performance.Example1v1.pipe 2>&1)