Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2.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 3.2.3+maint.om/package.mo", uses=false) loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo", uses=false) Using package Annex60 with version 1.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo) Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(Annex60.Fluid.Examples.Performance.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2") translateModel(Annex60.Fluid.Examples.Performance.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001047/0.001047, allocations: 86.95 kB / 15.06 MB, free: 1.09 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.001221/0.001222, allocations: 168.7 kB / 15.95 MB, free: 204 kB / 14.72 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.924/1.924, allocations: 205.4 MB / 222.1 MB, free: 5.652 MB / 174.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Annex60 1.0.0/package.mo): time 0.4406/0.4406, allocations: 55.02 MB / 325.4 MB, free: 0.6484 MB / 254.1 MB Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed. Notification: Annex60 requested package Modelica of version 3.2.2. Modelica 3.2.3 is used instead which states that it is fully compatible without conversion script needed. Notification: Performance of FrontEnd - loaded program: time 0.0006403/0.0006406, allocations: 12 kB / 396.6 MB, free: 11.67 MB / 334.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.4952/0.4959, allocations: 60.71 MB / 457.4 MB, free: 38.28 MB / 382.1 MB Notification: Performance of NFInst.instantiate(Annex60.Fluid.Examples.Performance.Example2): time 0.02566/0.5216, allocations: 27.05 MB / 484.4 MB, free: 22.75 MB / 382.1 MB Notification: Performance of NFInst.instExpressions: time 0.01783/0.5395, allocations: 11.28 MB / 495.7 MB, free: 15.08 MB / 382.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002184/0.5417, allocations: 36.34 kB / 495.7 MB, free: 15.07 MB / 382.1 MB Notification: Performance of NFTyping.typeComponents: time 0.002028/0.5438, allocations: 477.3 kB / 496.2 MB, free: 14.82 MB / 382.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:734:36-735:54:writable] Warning: 'each' used when modifying non-array element m_flow. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:732:36-733:54:writable] Warning: 'each' used when modifying non-array element m_flow. Notification: Performance of NFTyping.typeBindings: time 0.004075/0.5479, allocations: 1.174 MB / 497.4 MB, free: 14.18 MB / 382.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.003742/0.5516, allocations: 1.033 MB / 498.4 MB, free: 13.71 MB / 382.1 MB Notification: Performance of NFFlatten.flatten: time 0.008177/0.5598, allocations: 4.279 MB / 0.4909 GB, free: 12.01 MB / 382.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.002956/0.5628, allocations: 0.9636 MB / 0.4918 GB, free: 11.68 MB / 382.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.004355/0.5672, allocations: 1.19 MB / 0.493 GB, free: 11.23 MB / 382.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.003271/0.5705, allocations: 1.006 MB / 0.494 GB, free: 10.82 MB / 382.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0002644/0.5708, allocations: 52.75 kB / 0.494 GB, free: 10.82 MB / 382.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.003349/0.5742, allocations: 0.8552 MB / 0.4949 GB, free: 10.61 MB / 382.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0006479/0.5748, allocations: 330.5 kB / 0.4952 GB, free: 10.47 MB / 382.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0008752/0.5757, allocations: 319 kB / 0.4955 GB, free: 10.3 MB / 382.1 MB Notification: Performance of NFConvertDAE.convert: time 0.003774/0.5795, allocations: 1.815 MB / 0.4973 GB, free: 9.871 MB / 382.1 MB Notification: Performance of FrontEnd - DAE generated: time 7.283e-06/0.5795, allocations: 4 kB / 0.4973 GB, free: 9.867 MB / 382.1 MB Notification: Performance of FrontEnd: time 1.863e-06/0.5795, allocations: 0 / 0.4973 GB, free: 9.867 MB / 382.1 MB Notification: Performance of Transformations before backend: time 5.701e-05/0.5796, allocations: 1.031 kB / 0.4973 GB, free: 9.867 MB / 382.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 195 * Number of variables: 195 Notification: Performance of Generate backend data structure: time 0.004391/0.584, allocations: 1.701 MB / 0.4989 GB, free: 8.754 MB / 382.1 MB Notification: Performance of prepare preOptimizeDAE: time 4.852e-05/0.5841, allocations: 13.5 kB / 0.4989 GB, free: 8.75 MB / 382.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00137/0.5854, allocations: 259.1 kB / 0.4992 GB, free: 8.66 MB / 382.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.003041/0.5885, allocations: 1.248 MB / 0.5004 GB, free: 7.977 MB / 382.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000105/0.5886, allocations: 67.53 kB / 0.5005 GB, free: 7.945 MB / 382.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001591/0.5888, allocations: 83.69 kB / 0.5006 GB, free: 7.922 MB / 382.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.006123/0.5949, allocations: 1.914 MB / 0.5024 GB, free: 7.352 MB / 382.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 3.133e-05/0.595, allocations: 5.719 kB / 0.5024 GB, free: 7.348 MB / 382.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001094/0.5951, allocations: 41.08 kB / 0.5025 GB, free: 7.316 MB / 382.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.553e-05/0.5951, allocations: 21.25 kB / 0.5025 GB, free: 7.316 MB / 382.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005547/0.6007, allocations: 1.647 MB / 0.5041 GB, free: 7.004 MB / 382.1 MB 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.008872/0.6096, allocations: 5.51 MB / 0.5095 GB, free: 2.465 MB / 382.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.00448/0.6141, allocations: 1.474 MB / 0.5109 GB, free: 1.793 MB / 382.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.0007517/0.6149, allocations: 356.7 kB / 0.5113 GB, free: 1.621 MB / 382.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.002742/0.6177, allocations: 1.41 MB / 0.5126 GB, free: 404 kB / 382.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003945/0.6216, allocations: 1.247 MB / 0.5139 GB, free: 15.78 MB / 398.1 MB Notification: Performance of preOpt simplifyInStream (simulation): time 0.0009691/0.6226, allocations: 98.03 kB / 0.5139 GB, free: 15.72 MB / 398.1 MB Notification: Performance of pre-optimization done (n=44): time 3.095e-06/0.6226, allocations: 1.125 kB / 0.5139 GB, free: 15.72 MB / 398.1 MB Notification: Performance of matching and sorting (n=49): time 0.0241/0.6467, allocations: 6.567 MB / 0.5204 GB, free: 11.27 MB / 398.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001071/0.6469, allocations: 137 kB / 0.5205 GB, free: 11.11 MB / 398.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002257/0.6492, allocations: 1.321 MB / 0.5218 GB, free: 9.77 MB / 398.1 MB Notification: Performance of collectPreVariables (initialization): time 0.0002754/0.6494, allocations: 41.7 kB / 0.5218 GB, free: 9.723 MB / 398.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0006419/0.6501, allocations: 0.6565 MB / 0.5225 GB, free: 9.059 MB / 398.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0002212/0.6503, allocations: 165.6 kB / 0.5226 GB, free: 8.895 MB / 398.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 6.063e-05/0.6504, allocations: 16 kB / 0.5226 GB, free: 8.879 MB / 398.1 MB Notification: Performance of setup shared object (initialization): time 0.0001388/0.6505, allocations: 337.9 kB / 0.523 GB, free: 8.543 MB / 398.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001648/0.6522, allocations: 0.6419 MB / 0.5236 GB, free: 7.902 MB / 398.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001887/0.6541, allocations: 1.027 MB / 0.5246 GB, free: 6.707 MB / 398.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.001694/0.6558, allocations: 0.7179 MB / 0.5253 GB, free: 5.984 MB / 398.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.418e-06/0.6558, allocations: 0 / 0.5253 GB, free: 5.984 MB / 398.1 MB Notification: Performance of matching and sorting (n=94) (initialization): time 0.01208/0.6679, allocations: 3.73 MB / 0.5289 GB, free: 2.234 MB / 398.1 MB Notification: Performance of prepare postOptimizeDAE: time 0.0003362/0.6683, allocations: 369.9 kB / 0.5293 GB, free: 1.75 MB / 398.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.671e-05/0.6683, allocations: 8 kB / 0.5293 GB, free: 1.742 MB / 398.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.002474/0.6708, allocations: 1.009 MB / 0.5303 GB, free: 0.7305 MB / 398.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000833/0.6716, allocations: 163.7 kB / 0.5304 GB, free: 0.5703 MB / 398.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02529/0.6969, allocations: 9.327 MB / 0.5395 GB, free: 7.117 MB / 414.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00222/0.6992, allocations: 231.7 kB / 0.5398 GB, free: 6.891 MB / 414.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002058/0.6994, allocations: 40.08 kB / 0.5398 GB, free: 6.852 MB / 414.1 MB Notification: Performance of prepare postOptimizeDAE: time 1.39e-05/0.6994, allocations: 7.938 kB / 0.5398 GB, free: 6.844 MB / 414.1 MB Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002026/0.7015, allocations: 0.9535 MB / 0.5407 GB, free: 5.879 MB / 414.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.387e-05/0.7015, allocations: 8 kB / 0.5407 GB, free: 5.871 MB / 414.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0004018/0.7019, allocations: 138.3 kB / 0.5409 GB, free: 5.734 MB / 414.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005491/0.7025, allocations: 159.7 kB / 0.541 GB, free: 5.578 MB / 414.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002797/0.7053, allocations: 2.342 MB / 0.5433 GB, free: 3.09 MB / 414.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00147/0.7068, allocations: 91.83 kB / 0.5434 GB, free: 3 MB / 414.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.048e-05/0.7069, allocations: 32 kB / 0.5434 GB, free: 2.969 MB / 414.1 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 37 * Number of states: 0 () * Number of discrete variables: 7 ($whenCondition1,$PRE.pulse.T_start,pulse.T_start,$PRE.pulse.count,pulse.count,nRes.y,from_dp.y) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (81): * Single equations (assignments): 78 * Array equations: 1 * Algorithm blocks: 1 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (linear and non-linear blocks): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems: 0 * Non-linear torn systems: 1 {5 7} Notification: Performance of prepare postOptimizeDAE: time 0.001364/0.7082, allocations: 488.3 kB / 0.5439 GB, free: 2.484 MB / 414.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003936/0.7086, allocations: 130.4 kB / 0.544 GB, free: 2.355 MB / 414.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009462/0.7181, allocations: 2.995 MB / 0.547 GB, free: 15.34 MB / 430.1 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.683e-05/0.7182, allocations: 4 kB / 0.547 GB, free: 15.34 MB / 430.1 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 4.248e-06/0.7182, allocations: 0 / 0.547 GB, free: 15.34 MB / 430.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.009114/0.7273, allocations: 2.994 MB / 0.5499 GB, free: 12.28 MB / 430.1 MB 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.01249/0.7399, allocations: 4.279 MB / 0.5541 GB, free: 7.895 MB / 430.1 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.568e-05/0.7399, allocations: 0 / 0.5541 GB, free: 7.895 MB / 430.1 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006089/0.7405, allocations: 107.9 kB / 0.5542 GB, free: 7.789 MB / 430.1 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.002358/0.7429, allocations: 1.004 MB / 0.5551 GB, free: 6.785 MB / 430.1 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001032/0.743, allocations: 17.8 kB / 0.5552 GB, free: 6.77 MB / 430.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.02252/0.7656, allocations: 8.768 MB / 0.5637 GB, free: 13.86 MB / 446.1 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.07e-06/0.7656, allocations: 1.016 kB / 0.5637 GB, free: 13.86 MB / 446.1 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01126/0.7769, allocations: 3.793 MB / 0.5674 GB, free: 10.03 MB / 446.1 MB Notification: Performance of postOpt removeConstants (simulation): time 0.001241/0.7782, allocations: 315.4 kB / 0.5677 GB, free: 9.699 MB / 446.1 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001898/0.7784, allocations: 12 kB / 0.5677 GB, free: 9.688 MB / 446.1 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001296/0.7797, allocations: 229.3 kB / 0.568 GB, free: 9.465 MB / 446.1 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002144/0.7799, allocations: 68.33 kB / 0.568 GB, free: 9.398 MB / 446.1 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.387e-05/0.78, allocations: 27.92 kB / 0.568 GB, free: 9.371 MB / 446.1 MB Notification: Performance of sorting global known variables: time 0.00167/0.7817, allocations: 0.901 MB / 0.5689 GB, free: 8.469 MB / 446.1 MB Notification: Performance of sort global known variables: time 1.4e-07/0.7817, allocations: 0 / 0.5689 GB, free: 8.469 MB / 446.1 MB Notification: Performance of remove unused functions: time 0.003544/0.7852, allocations: 0.7187 MB / 0.5696 GB, free: 7.75 MB / 446.1 MB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 4 * Number of states: 1 (pump_dp.vol.dynBal.medium.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 (46): * Single equations (assignments): 40 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 3 * When equations: 2 * If-equations: 0 * Equation systems (linear and non-linear blocks): 0 * Torn equation systems: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems: 0 * Non-linear torn systems: 1 {5 7} Notification: Performance of Backend phase and start with SimCode phase: time 0.001115/0.7864, allocations: 329.5 kB / 0.5699 GB, free: 7.426 MB / 446.1 MB Notification: Performance of simCode: created initialization part: time 0.009586/0.796, allocations: 3.405 MB / 0.5733 GB, free: 3.977 MB / 446.1 MB Notification: Performance of simCode: created event and clocks part: time 1.262e-05/0.796, allocations: 0 / 0.5733 GB, free: 3.977 MB / 446.1 MB Notification: Performance of simCode: created simulation system equations: time 0.005835/0.8019, allocations: 1.91 MB / 0.5751 GB, free: 2.055 MB / 446.1 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003284/0.8052, allocations: 0.6136 MB / 0.5757 GB, free: 1.457 MB / 446.1 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005855/0.8111, allocations: 3.154 MB / 0.5788 GB, free: 14.27 MB / 462.1 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001088/0.8122, allocations: 1.28 MB / 0.5801 GB, free: 12.96 MB / 462.1 MB Notification: Performance of simCode: alias equations: time 0.001542/0.8137, allocations: 313.3 kB / 0.5804 GB, free: 12.65 MB / 462.1 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002763/0.814, allocations: 107.4 kB / 0.5805 GB, free: 12.55 MB / 462.1 MB Notification: Performance of SimCode: time 1.102e-06/0.814, allocations: 11.88 kB / 0.5805 GB, free: 12.54 MB / 462.1 MB Notification: Performance of Templates: time 0.06272/0.8768, allocations: 32.81 MB / 0.6125 GB, free: 11.91 MB / 494.1 MB make -j1 -f Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2.makefile Environment - environmentSimulation: (rm -f Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2.pipe ; mkfifo Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2.pipe ; head -c 1048576 < Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2.pipe >> ../files/Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2.sim & ./Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2 -abortSlowSimulation -alarm=480 -lv LOG_STATS > Annex60_1.0.0_Annex60.Fluid.Examples.Performance.Example2.pipe 2>&1) Environment - environmentSimulation: