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/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/package.mo", uses=false) Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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.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/ModelicaServices 4.0.0+maint.om/package.mo): time 0.006384/0.006384, allocations: 104.9 kB / 15.74 MB, free: 6.039 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.00127/0.00127, allocations: 193.1 kB / 16.67 MB, free: 5.973 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.358/1.358, allocations: 222.9 MB / 240.4 MB, free: 4.316 MB / 190.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.8055/0.8055, allocations: 132.2 MB / 422.7 MB, free: 1.676 MB / 350.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001288/0.001288, allocations: 63.2 kB / 0.5814 GB, free: 0.8281 MB / 430.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1636/0.1649, allocations: 80.2 MB / 0.6597 GB, free: 13.48 MB / 0.4981 GB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pump.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value. Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Examples.Performance.Example1v1): time 0.06444/0.2293, allocations: 72.31 MB / 0.7303 GB, free: 4.922 MB / 0.5606 GB Notification: Performance of NFInst.instExpressions: time 0.02266/0.252, allocations: 16.99 MB / 0.7469 GB, free: 3.883 MB / 0.5762 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.003182/0.2552, allocations: 95.44 kB / 0.747 GB, free: 3.789 MB / 0.5762 GB Notification: Performance of NFTyping.typeComponents: time 0.003007/0.2583, allocations: 0.9978 MB / 0.748 GB, free: 2.785 MB / 0.5762 GB Notification: Performance of NFTyping.typeBindings: time 0.007137/0.2654, allocations: 2.434 MB / 0.7503 GB, free: 352 kB / 0.5762 GB Notification: Performance of NFTyping.typeClassSections: time 0.006003/0.2714, allocations: 2.067 MB / 0.7523 GB, free: 14.29 MB / 0.5919 GB Notification: Performance of NFFlatten.flatten: time 0.008977/0.2804, allocations: 8.054 MB / 0.7602 GB, free: 6.215 MB / 0.5919 GB Notification: Performance of NFFlatten.resolveConnections: time 0.007554/0.288, allocations: 6.125 MB / 0.7662 GB, free: 24 kB / 0.5919 GB Notification: Performance of NFEvalConstants.evaluate: time 0.007051/0.2951, allocations: 3.356 MB / 0.7695 GB, free: 12.66 MB / 0.6075 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004484/0.2996, allocations: 2.493 MB / 0.7719 GB, free: 10.16 MB / 0.6075 GB Notification: Performance of NFPackage.collectConstants: time 0.001097/0.3007, allocations: 259.9 kB / 0.7722 GB, free: 9.906 MB / 0.6075 GB Notification: Performance of NFFlatten.collectFunctions: time 0.003873/0.3046, allocations: 1.369 MB / 0.7735 GB, free: 8.535 MB / 0.6075 GB Notification: Performance of NFScalarize.scalarize: time 0.001317/0.3059, allocations: 0.7666 MB / 0.7742 GB, free: 7.766 MB / 0.6075 GB Notification: Performance of NFVerifyModel.verify: time 0.004349/0.3103, allocations: 1.761 MB / 0.776 GB, free: 5.992 MB / 0.6075 GB Notification: Performance of NFConvertDAE.convert: time 0.00837/0.3187, allocations: 4.755 MB / 0.7806 GB, free: 1.223 MB / 0.6075 GB Notification: Performance of FrontEnd - DAE generated: time 6.753e-06/0.3187, allocations: 4 kB / 0.7806 GB, free: 1.219 MB / 0.6075 GB Notification: Performance of FrontEnd: time 1.693e-06/0.3187, allocations: 0 / 0.7806 GB, free: 1.219 MB / 0.6075 GB Notification: Performance of Transformations before backend: time 0.0001695/0.3189, allocations: 4 kB / 0.7806 GB, free: 1.215 MB / 0.6075 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.008412/0.3273, allocations: 3.946 MB / 0.7845 GB, free: 13.19 MB / 0.6231 GB Notification: Performance of prepare preOptimizeDAE: time 3.878e-05/0.3274, allocations: 8.031 kB / 0.7845 GB, free: 13.18 MB / 0.6231 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002279/0.3297, allocations: 0.5461 MB / 0.785 GB, free: 12.63 MB / 0.6231 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.004886/0.3346, allocations: 2.748 MB / 0.7877 GB, free: 9.812 MB / 0.6231 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.481e-05/0.3347, allocations: 135.1 kB / 0.7878 GB, free: 9.68 MB / 0.6231 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002735/0.335, allocations: 187.9 kB / 0.788 GB, free: 9.496 MB / 0.6231 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003609/0.3386, allocations: 2.326 MB / 0.7903 GB, free: 7.016 MB / 0.6231 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.525e-05/0.3386, allocations: 7.938 kB / 0.7903 GB, free: 7.008 MB / 0.6231 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001663/0.3388, allocations: 68 kB / 0.7903 GB, free: 6.941 MB / 0.6231 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.854e-05/0.3388, allocations: 40 kB / 0.7904 GB, free: 6.902 MB / 0.6231 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003591/0.3424, allocations: 1.865 MB / 0.7922 GB, free: 5.031 MB / 0.6231 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.01351/0.356, allocations: 11.09 MB / 0.803 GB, free: 9.434 MB / 0.6387 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002562/0.3586, allocations: 1.34 MB / 0.8043 GB, free: 8.094 MB / 0.6387 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001529/0.3601, allocations: 1.005 MB / 0.8053 GB, free: 7.086 MB / 0.6387 GB Notification: Performance of preOpt evalFunc (simulation): time 0.005346/0.3655, allocations: 3.635 MB / 0.8089 GB, free: 3.18 MB / 0.6387 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001373/0.3669, allocations: 0.774 MB / 0.8096 GB, free: 2.395 MB / 0.6387 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.0009813/0.3678, allocations: 234.8 kB / 0.8098 GB, free: 2.164 MB / 0.6387 GB Notification: Performance of pre-optimization done (n=95): time 3.085e-06/0.3679, allocations: 0 / 0.8098 GB, free: 2.164 MB / 0.6387 GB Notification: Performance of matching and sorting (n=95): time 0.445/0.8129, allocations: 4.161 MB / 0.8139 GB, free: 146 MB / 0.6387 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.607e-05/0.813, allocations: 67.52 kB / 0.814 GB, free: 145.9 MB / 0.6387 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005397/0.8184, allocations: 2.881 MB / 0.8168 GB, free: 145.1 MB / 0.6387 GB Notification: Performance of collectPreVariables (initialization): time 0.0003198/0.8187, allocations: 57.7 kB / 0.8168 GB, free: 145.1 MB / 0.6387 GB Notification: Performance of collectInitialEqns (initialization): time 0.001431/0.8202, allocations: 1.419 MB / 0.8182 GB, free: 144.2 MB / 0.6387 GB Notification: Performance of collectInitialBindings (initialization): time 0.0004031/0.8206, allocations: 336.3 kB / 0.8185 GB, free: 144.1 MB / 0.6387 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0007029/0.8213, allocations: 352.6 kB / 0.8189 GB, free: 143.9 MB / 0.6387 GB Notification: Performance of setup shared object (initialization): time 5.743e-05/0.8214, allocations: 305.7 kB / 0.8192 GB, free: 143.6 MB / 0.6387 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001555/0.8229, allocations: 0.6803 MB / 0.8198 GB, free: 143.4 MB / 0.6387 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001937/0.8249, allocations: 1.429 MB / 0.8212 GB, free: 142.2 MB / 0.6387 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.00311/0.828, allocations: 1.914 MB / 0.8231 GB, free: 141 MB / 0.6387 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.37e-05/0.828, allocations: 7.875 kB / 0.8231 GB, free: 141 MB / 0.6387 GB Notification: Performance of matching and sorting (n=183) (initialization): time 0.006675/0.8347, allocations: 2.841 MB / 0.8259 GB, free: 140 MB / 0.6387 GB Notification: Performance of prepare postOptimizeDAE: time 5.568e-05/0.8348, allocations: 37.86 kB / 0.8259 GB, free: 139.9 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.409e-05/0.8348, allocations: 19.31 kB / 0.8259 GB, free: 139.9 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.002491/0.8373, allocations: 0.685 MB / 0.8266 GB, free: 139.8 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001368/0.8387, allocations: 294.8 kB / 0.8269 GB, free: 139.8 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001956/0.8407, allocations: 1.9 MB / 0.8287 GB, free: 138.4 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002396/0.8431, allocations: 101.6 kB / 0.8288 GB, free: 138.4 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002258/0.8433, allocations: 86.17 kB / 0.8289 GB, free: 138.4 MB / 0.6387 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002701/0.846, allocations: 1.277 MB / 0.8302 GB, free: 137.9 MB / 0.6387 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001462/0.8475, allocations: 1.385 MB / 0.8315 GB, free: 136.7 MB / 0.6387 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002365/0.8499, allocations: 1.824 MB / 0.8333 GB, free: 135.6 MB / 0.6387 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.105e-06/0.8499, allocations: 3.969 kB / 0.8333 GB, free: 135.6 MB / 0.6387 GB Notification: Performance of matching and sorting (n=183) (initialization_lambda0): time 0.004534/0.8544, allocations: 2.689 MB / 0.8359 GB, free: 134.5 MB / 0.6387 GB Notification: Performance of prepare postOptimizeDAE: time 3.657e-05/0.8545, allocations: 41.14 kB / 0.836 GB, free: 134.4 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.538e-05/0.8545, allocations: 15.75 kB / 0.836 GB, free: 134.4 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.0007805/0.8553, allocations: 470.3 kB / 0.8364 GB, free: 134.3 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001082/0.8564, allocations: 295.2 kB / 0.8367 GB, free: 134.3 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005853/0.8623, allocations: 6.342 MB / 0.8429 GB, free: 129.4 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002349/0.8646, allocations: 107.6 kB / 0.843 GB, free: 129.3 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002031/0.8649, allocations: 78.75 kB / 0.8431 GB, free: 129.3 MB / 0.6387 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 66 * 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 (135): * Single equations (assignments): 131 * 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.0005588/0.8654, allocations: 286.4 kB / 0.8434 GB, free: 129.1 MB / 0.6387 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004791/0.8659, allocations: 300.3 kB / 0.8437 GB, free: 128.9 MB / 0.6387 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004243/0.8702, allocations: 2.427 MB / 0.846 GB, free: 127.3 MB / 0.6387 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.703e-05/0.8702, allocations: 12 kB / 0.846 GB, free: 127.3 MB / 0.6387 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 3.767e-06/0.8702, allocations: 4 kB / 0.846 GB, free: 127.3 MB / 0.6387 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002762/0.873, allocations: 2.054 MB / 0.848 GB, free: 125.2 MB / 0.6387 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006232/0.8792, allocations: 4.369 MB / 0.8523 GB, free: 120.8 MB / 0.6387 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.504e-06/0.8793, allocations: 8 kB / 0.8523 GB, free: 120.8 MB / 0.6387 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007934/0.8801, allocations: 167.5 kB / 0.8525 GB, free: 120.6 MB / 0.6387 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0008728/0.881, allocations: 476.5 kB / 0.8529 GB, free: 120.2 MB / 0.6387 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.267e-05/0.881, allocations: 31.92 kB / 0.853 GB, free: 120.1 MB / 0.6387 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001213/0.8823, allocations: 1.854 MB / 0.8548 GB, free: 118.2 MB / 0.6387 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.275e-06/0.8823, allocations: 0 / 0.8548 GB, free: 118.2 MB / 0.6387 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00473/0.887, allocations: 3.118 MB / 0.8578 GB, free: 115.1 MB / 0.6387 GB Notification: Performance of postOpt removeConstants (simulation): time 0.001266/0.8883, allocations: 489.1 kB / 0.8583 GB, free: 114.6 MB / 0.6387 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005346/0.8888, allocations: 24 kB / 0.8583 GB, free: 114.6 MB / 0.6387 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001168/0.89, allocations: 67.78 kB / 0.8584 GB, free: 114.5 MB / 0.6387 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001647/0.8902, allocations: 72.89 kB / 0.8584 GB, free: 114.4 MB / 0.6387 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 9.054e-05/0.8903, allocations: 47.97 kB / 0.8585 GB, free: 114.4 MB / 0.6387 GB Notification: Performance of sorting global known variables: time 0.002348/0.8926, allocations: 1.973 MB / 0.8604 GB, free: 112.4 MB / 0.6387 GB Notification: Performance of sort global known variables: time 1.9e-07/0.8927, allocations: 0 / 0.8604 GB, free: 112.4 MB / 0.6387 GB Notification: Performance of remove unused functions: time 0.003349/0.896, allocations: 1.34 MB / 0.8617 GB, free: 111.1 MB / 0.6387 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 (79): * Single equations (assignments): 71 * 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.001032/0.8971, allocations: 469.4 kB / 0.8622 GB, free: 110.7 MB / 0.6387 GB Notification: Performance of simCode: created initialization part: time 0.005051/0.9021, allocations: 3.174 MB / 0.8653 GB, free: 107.5 MB / 0.6387 GB Notification: Performance of simCode: created event and clocks part: time 5.12e-06/0.9021, allocations: 0 / 0.8653 GB, free: 107.5 MB / 0.6387 GB Notification: Performance of simCode: created simulation system equations: time 0.00126/0.9034, allocations: 0.7969 MB / 0.866 GB, free: 106.7 MB / 0.6387 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005136/0.9086, allocations: 1.251 MB / 0.8673 GB, free: 105.5 MB / 0.6387 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007112/0.9157, allocations: 5.137 MB / 0.8723 GB, free: 100.4 MB / 0.6387 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001076/0.9168, allocations: 2.065 MB / 0.8743 GB, free: 98.26 MB / 0.6387 GB Notification: Performance of simCode: alias equations: time 0.002311/0.9191, allocations: 0.6729 MB / 0.875 GB, free: 97.6 MB / 0.6387 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004354/0.9196, allocations: 211.4 kB / 0.8752 GB, free: 97.39 MB / 0.6387 GB Notification: Performance of SimCode: time 1.223e-06/0.9196, allocations: 0 / 0.8752 GB, free: 97.39 MB / 0.6387 GB Notification: Performance of Templates: time 0.07361/0.9932, allocations: 54.93 MB / 0.9288 GB, free: 43.21 MB / 0.6387 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)