Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3.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.Example3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3") translateModel(IDEAS.Fluid.Examples.Performance.Example3,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001416/0.00142, allocations: 103.4 kB / 15.33 MB, free: 0.5078 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.001476/0.001476, allocations: 195.9 kB / 16.26 MB, free: 6.621 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.362/1.362, allocations: 222.9 MB / 239.9 MB, free: 4.527 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.9369/0.9369, allocations: 135.6 MB / 425.6 MB, free: 11.94 MB / 350.1 MB Notification: Performance of FrontEnd - loaded program: time 0.00196/0.00196, allocations: 68.67 kB / 0.5054 GB, free: 5.23 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1603/0.1623, allocations: 81.02 MB / 0.5845 GB, free: 4.352 MB / 494.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Examples.Performance.Example3): time 0.2852/0.4475, allocations: 32.47 MB / 0.6162 GB, free: 35.51 MB / 0.4981 GB Notification: Performance of NFInst.instExpressions: time 0.01231/0.4599, allocations: 10.42 MB / 0.6264 GB, free: 29.74 MB / 0.4981 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.001766/0.4617, allocations: 48 kB / 0.6264 GB, free: 29.72 MB / 0.4981 GB Notification: Performance of NFTyping.typeComponents: time 0.001933/0.4636, allocations: 0.6488 MB / 0.6271 GB, free: 29.39 MB / 0.4981 GB Notification: Performance of NFTyping.typeBindings: time 0.004331/0.468, allocations: 1.454 MB / 0.6285 GB, free: 28.57 MB / 0.4981 GB Notification: Performance of NFTyping.typeClassSections: time 0.002982/0.471, allocations: 1.29 MB / 0.6297 GB, free: 27.89 MB / 0.4981 GB Notification: Performance of NFFlatten.flatten: time 0.004477/0.4755, allocations: 4.904 MB / 0.6345 GB, free: 25.64 MB / 0.4981 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002073/0.4776, allocations: 2.067 MB / 0.6365 GB, free: 24.74 MB / 0.4981 GB Notification: Performance of NFEvalConstants.evaluate: time 0.003313/0.4809, allocations: 1.943 MB / 0.6384 GB, free: 23.9 MB / 0.4981 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001563/0.4825, allocations: 1.413 MB / 0.6398 GB, free: 23.26 MB / 0.4981 GB Notification: Performance of NFPackage.collectConstants: time 0.0001967/0.4827, allocations: 145.3 kB / 0.64 GB, free: 23.26 MB / 0.4981 GB Notification: Performance of NFFlatten.collectFunctions: time 0.001993/0.4847, allocations: 1.17 MB / 0.6411 GB, free: 22.93 MB / 0.4981 GB Notification: Performance of NFScalarize.scalarize: time 0.0003454/0.4851, allocations: 470.2 kB / 0.6415 GB, free: 22.68 MB / 0.4981 GB Notification: Performance of NFVerifyModel.verify: time 0.0008748/0.486, allocations: 1.01 MB / 0.6425 GB, free: 22.07 MB / 0.4981 GB Notification: Performance of NFConvertDAE.convert: time 0.002473/0.4884, allocations: 2.926 MB / 0.6454 GB, free: 20.98 MB / 0.4981 GB Notification: Performance of FrontEnd - DAE generated: time 4.348e-06/0.4885, allocations: 0 / 0.6454 GB, free: 20.98 MB / 0.4981 GB Notification: Performance of FrontEnd: time 1.262e-06/0.4885, allocations: 0 / 0.6454 GB, free: 20.98 MB / 0.4981 GB Notification: Performance of Transformations before backend: time 2.375e-05/0.4885, allocations: 0 / 0.6454 GB, free: 20.98 MB / 0.4981 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 235 * Number of variables: 235 Notification: Performance of Generate backend data structure: time 0.003363/0.4919, allocations: 2.388 MB / 0.6477 GB, free: 19.43 MB / 0.4981 GB Notification: Performance of prepare preOptimizeDAE: time 4.204e-05/0.4919, allocations: 9.031 kB / 0.6477 GB, free: 19.43 MB / 0.4981 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001218/0.4931, allocations: 301.2 kB / 0.648 GB, free: 19.32 MB / 0.4981 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002628/0.4958, allocations: 1.653 MB / 0.6496 GB, free: 18.44 MB / 0.4981 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.865e-05/0.4959, allocations: 78.53 kB / 0.6497 GB, free: 18.4 MB / 0.4981 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001715/0.496, allocations: 105.1 kB / 0.6498 GB, free: 18.37 MB / 0.4981 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002021/0.4981, allocations: 1.284 MB / 0.6511 GB, free: 17.77 MB / 0.4981 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.935e-05/0.4981, allocations: 4.781 kB / 0.6511 GB, free: 17.76 MB / 0.4981 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001042/0.4982, allocations: 39.5 kB / 0.6511 GB, free: 17.73 MB / 0.4981 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.551e-05/0.4983, allocations: 22.69 kB / 0.6511 GB, free: 17.73 MB / 0.4981 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001747/0.5, allocations: 0.9921 MB / 0.6521 GB, free: 17.39 MB / 0.4981 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.00712/0.5071, allocations: 6.745 MB / 0.6587 GB, free: 12.19 MB / 0.4981 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001251/0.5084, allocations: 0.5823 MB / 0.6593 GB, free: 11.98 MB / 0.4981 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0006642/0.5091, allocations: 395 kB / 0.6596 GB, free: 11.84 MB / 0.4981 GB Notification: Performance of preOpt evalFunc (simulation): time 0.002711/0.5118, allocations: 1.685 MB / 0.6613 GB, free: 10.61 MB / 0.4981 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0007601/0.5126, allocations: 360.2 kB / 0.6616 GB, free: 10.47 MB / 0.4981 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.0007095/0.5133, allocations: 101.6 kB / 0.6617 GB, free: 10.42 MB / 0.4981 GB Notification: Performance of pre-optimization done (n=46): time 2.375e-06/0.5133, allocations: 0 / 0.6617 GB, free: 10.42 MB / 0.4981 GB Notification: Performance of matching and sorting (n=46): time 0.003435/0.5168, allocations: 1.313 MB / 0.663 GB, free: 9.922 MB / 0.4981 GB Notification: Performance of inlineWhenForInitialization (initialization): time 3.514e-05/0.5168, allocations: 69.5 kB / 0.6631 GB, free: 9.848 MB / 0.4981 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002395/0.5192, allocations: 1.781 MB / 0.6648 GB, free: 9.188 MB / 0.4981 GB Notification: Performance of collectPreVariables (initialization): time 7.177e-05/0.5193, allocations: 39.42 kB / 0.6648 GB, free: 9.148 MB / 0.4981 GB Notification: Performance of collectInitialEqns (initialization): time 0.0006272/0.5199, allocations: 0.8524 MB / 0.6657 GB, free: 8.477 MB / 0.4981 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001356/0.5201, allocations: 167.5 kB / 0.6658 GB, free: 8.348 MB / 0.4981 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002675/0.5203, allocations: 186 kB / 0.666 GB, free: 8.266 MB / 0.4981 GB Notification: Performance of setup shared object (initialization): time 6.942e-05/0.5204, allocations: 339.3 kB / 0.6663 GB, free: 7.945 MB / 0.4981 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006259/0.521, allocations: 319.1 kB / 0.6666 GB, free: 7.84 MB / 0.4981 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008296/0.5219, allocations: 0.7465 MB / 0.6674 GB, free: 7.164 MB / 0.4981 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.00135/0.5232, allocations: 0.983 MB / 0.6683 GB, free: 6.473 MB / 0.4981 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.448e-06/0.5233, allocations: 3.25 kB / 0.6683 GB, free: 6.473 MB / 0.4981 GB Notification: Performance of matching and sorting (n=99) (initialization): time 0.002826/0.5261, allocations: 1.314 MB / 0.6696 GB, free: 5.93 MB / 0.4981 GB Notification: Performance of prepare postOptimizeDAE: time 4.33e-05/0.5261, allocations: 36.59 kB / 0.6696 GB, free: 5.898 MB / 0.4981 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.794e-05/0.5262, allocations: 10.12 kB / 0.6697 GB, free: 5.898 MB / 0.4981 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0007042/0.5269, allocations: 188.4 kB / 0.6698 GB, free: 5.859 MB / 0.4981 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006627/0.5276, allocations: 169.9 kB / 0.67 GB, free: 5.844 MB / 0.4981 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006027/0.5282, allocations: 0.7596 MB / 0.6707 GB, free: 5.246 MB / 0.4981 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001427/0.5296, allocations: 98.45 kB / 0.6708 GB, free: 5.211 MB / 0.4981 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.277e-05/0.5297, allocations: 46.56 kB / 0.6709 GB, free: 5.207 MB / 0.4981 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001254/0.531, allocations: 0.7103 MB / 0.6716 GB, free: 4.918 MB / 0.4981 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0006956/0.5317, allocations: 0.7053 MB / 0.6723 GB, free: 4.262 MB / 0.4981 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001175/0.5329, allocations: 0.9264 MB / 0.6732 GB, free: 3.578 MB / 0.4981 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.903e-06/0.5329, allocations: 4.062 kB / 0.6732 GB, free: 3.578 MB / 0.4981 GB Notification: Performance of matching and sorting (n=99) (initialization_lambda0): time 0.002224/0.5351, allocations: 1.275 MB / 0.6744 GB, free: 2.977 MB / 0.4981 GB Notification: Performance of prepare postOptimizeDAE: time 3.404e-05/0.5352, allocations: 38.47 kB / 0.6745 GB, free: 2.945 MB / 0.4981 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.194e-05/0.5352, allocations: 9.969 kB / 0.6745 GB, free: 2.945 MB / 0.4981 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.000235/0.5354, allocations: 123.8 kB / 0.6746 GB, free: 2.914 MB / 0.4981 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005639/0.536, allocations: 162.5 kB / 0.6747 GB, free: 2.898 MB / 0.4981 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001885/0.5379, allocations: 2.332 MB / 0.677 GB, free: 1.035 MB / 0.4981 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00127/0.5392, allocations: 84.69 kB / 0.6771 GB, free: 1.016 MB / 0.4981 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.718e-05/0.5392, allocations: 46.36 kB / 0.6771 GB, free: 1.008 MB / 0.4981 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 46 * Number of states: 0 () * Number of discrete variables: 8 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,nRes.y,from_dp.y,mergeDp.y) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (85): * Single equations (assignments): 82 * Array equations: 1 * Algorithm blocks: 1 * Record equations: 0 * When equations: 0 * 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): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,12)} Notification: Performance of prepare postOptimizeDAE: time 0.0003015/0.5396, allocations: 246.9 kB / 0.6774 GB, free: 0.7812 MB / 0.4981 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002162/0.5398, allocations: 174.5 kB / 0.6775 GB, free: 0.6875 MB / 0.4981 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002069/0.5418, allocations: 1.008 MB / 0.6785 GB, free: 300 kB / 0.4981 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.14e-05/0.5419, allocations: 14.58 kB / 0.6785 GB, free: 292 kB / 0.4981 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 2.395e-06/0.5419, allocations: 1.625 kB / 0.6785 GB, free: 292 kB / 0.4981 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001507/0.5434, allocations: 0.9498 MB / 0.6795 GB, free: 15.71 MB / 0.5137 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004012/0.5474, allocations: 2.096 MB / 0.6815 GB, free: 14.73 MB / 0.5137 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.604e-06/0.5474, allocations: 4.797 kB / 0.6815 GB, free: 14.73 MB / 0.5137 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004657/0.5479, allocations: 93.38 kB / 0.6816 GB, free: 14.71 MB / 0.5137 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0003036/0.5482, allocations: 126.5 kB / 0.6817 GB, free: 14.67 MB / 0.5137 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.607e-05/0.5483, allocations: 19.48 kB / 0.6817 GB, free: 14.66 MB / 0.5137 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0006472/0.5489, allocations: 0.7294 MB / 0.6825 GB, free: 14.08 MB / 0.5137 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.833e-06/0.5489, allocations: 0 / 0.6825 GB, free: 14.08 MB / 0.5137 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002647/0.5516, allocations: 1.367 MB / 0.6838 GB, free: 13.43 MB / 0.5137 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0007523/0.5524, allocations: 304.4 kB / 0.6841 GB, free: 13.2 MB / 0.5137 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002158/0.5526, allocations: 6.969 kB / 0.6841 GB, free: 13.2 MB / 0.5137 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007959/0.5534, allocations: 69.7 kB / 0.6842 GB, free: 13.18 MB / 0.5137 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001119/0.5535, allocations: 44.3 kB / 0.6842 GB, free: 13.17 MB / 0.5137 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.766e-05/0.5536, allocations: 28.44 kB / 0.6842 GB, free: 13.16 MB / 0.5137 GB Notification: Performance of sorting global known variables: time 0.002176/0.5558, allocations: 1.231 MB / 0.6854 GB, free: 12.71 MB / 0.5137 GB Notification: Performance of sort global known variables: time 1.7e-07/0.5558, allocations: 1.406 kB / 0.6854 GB, free: 12.71 MB / 0.5137 GB Notification: Performance of remove unused functions: time 0.003156/0.5589, allocations: 0.7849 MB / 0.6862 GB, free: 12.57 MB / 0.5137 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 1 (pump.vol.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 (41): * Single equations (assignments): 35 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 3 * 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): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,12)} Notification: Performance of Backend phase and start with SimCode phase: time 0.001215/0.5602, allocations: 372.3 kB / 0.6865 GB, free: 12.39 MB / 0.5137 GB Notification: Performance of simCode: created initialization part: time 0.003492/0.5637, allocations: 1.541 MB / 0.6881 GB, free: 11.72 MB / 0.5137 GB Notification: Performance of simCode: created event and clocks part: time 3.907e-06/0.5637, allocations: 0 / 0.6881 GB, free: 11.72 MB / 0.5137 GB Notification: Performance of simCode: created simulation system equations: time 0.0007596/0.5645, allocations: 334.8 kB / 0.6884 GB, free: 11.62 MB / 0.5137 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00384/0.5683, allocations: 0.7786 MB / 0.6891 GB, free: 11.38 MB / 0.5137 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006252/0.5746, allocations: 3.478 MB / 0.6925 GB, free: 9.441 MB / 0.5137 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00149/0.5761, allocations: 1.505 MB / 0.694 GB, free: 8.594 MB / 0.5137 GB Notification: Performance of simCode: alias equations: time 0.001914/0.578, allocations: 454.7 kB / 0.6944 GB, free: 8.383 MB / 0.5137 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003674/0.5784, allocations: 126.6 kB / 0.6946 GB, free: 8.359 MB / 0.5137 GB Notification: Performance of SimCode: time 6.21e-07/0.5784, allocations: 0 / 0.6946 GB, free: 8.359 MB / 0.5137 GB Notification: Performance of Templates: time 0.05934/0.6377, allocations: 31.23 MB / 0.7251 GB, free: 10.98 MB / 0.545 GB make -j1 -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3.makefile (rm -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3.sim & ./IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3 -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example3.pipe 2>&1)