Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_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-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.Example1v1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1")
translateModel(IDEAS.Fluid.Examples.Performance.Example1v1,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_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.001124/0.001124, allocations: 113.7 kB / 16.42 MB, free: 6.457 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.001014/0.001014, allocations: 185.5 kB / 17.35 MB, free: 5.734 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.304/1.304, allocations: 222.9 MB / 241 MB, free: 15.1 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8032/0.8032, allocations: 135.1 MB / 426.3 MB, free: 4.141 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001291/0.001291, allocations: 64.66 kB / 0.5863 GB, free: 21.51 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.132/0.1333, allocations: 80.92 MB / 0.6653 GB, free: 5.801 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.0663/0.1996, allocations: 72.3 MB / 0.7359 GB, free: 13.25 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.3361/0.5357, allocations: 16.98 MB / 0.7525 GB, free: 11.75 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002971/0.5387, allocations: 91.84 kB / 0.7526 GB, free: 11.75 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.002823/0.5416, allocations: 1.008 MB / 0.7536 GB, free: 11.75 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.005793/0.5474, allocations: 2.428 MB / 0.7559 GB, free: 11.69 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004589/0.552, allocations: 2.079 MB / 0.758 GB, free: 11.63 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.009692/0.5617, allocations: 8.051 MB / 0.7658 GB, free: 11.6 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00765/0.5694, allocations: 6.142 MB / 0.7718 GB, free: 10.74 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006724/0.5761, allocations: 3.35 MB / 0.7751 GB, free: 10.43 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.004262/0.5804, allocations: 2.492 MB / 0.7775 GB, free: 9.984 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0007688/0.5812, allocations: 254.5 kB / 0.7778 GB, free: 9.984 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00363/0.5848, allocations: 1.38 MB / 0.7791 GB, free: 9.957 MB / 0.5762 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006456/0.5855, allocations: 0.7625 MB / 0.7799 GB, free: 9.828 MB / 0.5762 GB
Notification: Performance of NFVerifyModel.verify: time 0.002062/0.5875, allocations: 1.772 MB / 0.7816 GB, free: 9.309 MB / 0.5762 GB
Notification: Performance of NFConvertDAE.convert: time 0.004781/0.5923, allocations: 4.777 MB / 0.7863 GB, free: 8.562 MB / 0.5762 GB
Notification: Performance of FrontEnd - DAE generated: time 4.298e-06/0.5923, allocations: 2.875 kB / 0.7863 GB, free: 8.562 MB / 0.5762 GB
Notification: Performance of FrontEnd: time 1.152e-06/0.5923, allocations: 0 / 0.7863 GB, free: 8.562 MB / 0.5762 GB
Notification: Performance of Transformations before backend: time 5.293e-05/0.5924, allocations: 0 / 0.7863 GB, free: 8.562 MB / 0.5762 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.005571/0.598, allocations: 4.048 MB / 0.7902 GB, free: 6.312 MB / 0.5762 GB
Notification: Performance of prepare preOptimizeDAE: time 3.75e-05/0.598, allocations: 14.66 kB / 0.7902 GB, free: 6.309 MB / 0.5762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001943/0.6, allocations: 0.5712 MB / 0.7908 GB, free: 6.023 MB / 0.5762 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003955/0.6039, allocations: 2.778 MB / 0.7935 GB, free: 4.477 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.736e-05/0.604, allocations: 136.5 kB / 0.7936 GB, free: 4.418 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002481/0.6043, allocations: 186.8 kB / 0.7938 GB, free: 4.359 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003075/0.6074, allocations: 2.325 MB / 0.7961 GB, free: 2.789 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.814e-05/0.6074, allocations: 9.625 kB / 0.7961 GB, free: 2.789 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001586/0.6076, allocations: 74.67 kB / 0.7962 GB, free: 2.734 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.589e-05/0.6076, allocations: 44.66 kB / 0.7962 GB, free: 2.73 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003008/0.6106, allocations: 1.861 MB / 0.798 GB, free: 1.797 MB / 0.5762 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.01107/0.6217, allocations: 11.1 MB / 0.8089 GB, free: 8.621 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002522/0.6242, allocations: 1.34 MB / 0.8102 GB, free: 7.93 MB / 0.5919 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001512/0.6258, allocations: 1.007 MB / 0.8112 GB, free: 7.434 MB / 0.5919 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.005167/0.6309, allocations: 3.648 MB / 0.8147 GB, free: 4.289 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001372/0.6323, allocations: 0.7701 MB / 0.8155 GB, free: 3.516 MB / 0.5919 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0007619/0.6331, allocations: 236.2 kB / 0.8157 GB, free: 3.289 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=95): time 2.564e-06/0.6331, allocations: 0 / 0.8157 GB, free: 3.289 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=95): time 0.01138/0.6445, allocations: 4.178 MB / 0.8198 GB, free: 15.09 MB / 0.6075 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.583e-05/0.6445, allocations: 60.41 kB / 0.8198 GB, free: 15.02 MB / 0.6075 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003242/0.6478, allocations: 2.88 MB / 0.8226 GB, free: 12.14 MB / 0.6075 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001091/0.6479, allocations: 57.7 kB / 0.8227 GB, free: 12.08 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001083/0.649, allocations: 1.439 MB / 0.8241 GB, free: 10.64 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002611/0.6493, allocations: 355.4 kB / 0.8244 GB, free: 10.29 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004985/0.6498, allocations: 358.7 kB / 0.8248 GB, free: 9.938 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 7.835e-05/0.6499, allocations: 301.1 kB / 0.8251 GB, free: 9.641 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001271/0.6511, allocations: 0.6809 MB / 0.8257 GB, free: 8.957 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001733/0.6529, allocations: 1.438 MB / 0.8271 GB, free: 7.172 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002854/0.6557, allocations: 1.908 MB / 0.829 GB, free: 5.059 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.025e-06/0.6558, allocations: 4 kB / 0.829 GB, free: 5.055 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=183) (initialization): time 0.005532/0.6613, allocations: 2.849 MB / 0.8318 GB, free: 2.191 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 4.235e-05/0.6614, allocations: 40.23 kB / 0.8318 GB, free: 2.148 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.652e-05/0.6614, allocations: 16 kB / 0.8319 GB, free: 2.133 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002422/0.6638, allocations: 0.6933 MB / 0.8325 GB, free: 1.441 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001156/0.665, allocations: 294.5 kB / 0.8328 GB, free: 1.152 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001754/0.6667, allocations: 1.91 MB / 0.8347 GB, free: 15.2 MB / 0.6231 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001502/0.6683, allocations: 101 kB / 0.8348 GB, free: 15.1 MB / 0.6231 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001515/0.6684, allocations: 87.95 kB / 0.8349 GB, free: 15.01 MB / 0.6231 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001983/0.6704, allocations: 1.277 MB / 0.8361 GB, free: 13.73 MB / 0.6231 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001578/0.672, allocations: 1.385 MB / 0.8375 GB, free: 12 MB / 0.6231 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002555/0.6746, allocations: 1.82 MB / 0.8392 GB, free: 9.965 MB / 0.6231 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.723e-06/0.6746, allocations: 4 kB / 0.8392 GB, free: 9.961 MB / 0.6231 GB
Notification: Performance of matching and sorting (n=183) (initialization_lambda0): time 0.004275/0.6789, allocations: 2.701 MB / 0.8419 GB, free: 7.215 MB / 0.6231 GB
Notification: Performance of prepare postOptimizeDAE: time 3.403e-05/0.6789, allocations: 45.69 kB / 0.8419 GB, free: 7.164 MB / 0.6231 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.367e-05/0.6789, allocations: 16 kB / 0.8419 GB, free: 7.148 MB / 0.6231 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008798/0.6798, allocations: 469.9 kB / 0.8424 GB, free: 6.684 MB / 0.6231 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001088/0.6809, allocations: 303 kB / 0.8427 GB, free: 6.391 MB / 0.6231 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.006383/0.6873, allocations: 6.342 MB / 0.8489 GB, free: 15.77 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001466/0.6888, allocations: 109.5 kB / 0.849 GB, free: 15.66 MB / 0.6387 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001324/0.6889, allocations: 79.95 kB / 0.849 GB, free: 15.59 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.0003412/0.6893, allocations: 296.5 kB / 0.8493 GB, free: 15.29 MB / 0.6387 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003695/0.6897, allocations: 310 kB / 0.8496 GB, free: 14.99 MB / 0.6387 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004502/0.6942, allocations: 2.419 MB / 0.852 GB, free: 12.57 MB / 0.6387 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003319/0.6975, allocations: 2.056 MB / 0.854 GB, free: 10.45 MB / 0.6387 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.328e-06/0.6975, allocations: 0 / 0.854 GB, free: 10.45 MB / 0.6387 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006931/0.6982, allocations: 0.4949 MB / 0.8545 GB, free: 9.934 MB / 0.6387 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002972/0.6985, allocations: 20 kB / 0.8545 GB, free: 9.914 MB / 0.6387 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00102/0.6996, allocations: 67.84 kB / 0.8546 GB, free: 9.848 MB / 0.6387 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002175/0.6998, allocations: 128.7 kB / 0.8547 GB, free: 9.723 MB / 0.6387 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.004197/0.704, allocations: 2.029 MB / 0.8567 GB, free: 7.711 MB / 0.6387 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.004092/0.7081, allocations: 2.588 MB / 0.8592 GB, free: 5.105 MB / 0.6387 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.00114/0.7092, allocations: 0.6755 MB / 0.8598 GB, free: 4.434 MB / 0.6387 GB
Notification: Performance of sorting global known variables: time 0.002443/0.7117, allocations: 1.975 MB / 0.8618 GB, free: 2.469 MB / 0.6387 GB
Notification: Performance of Backend: time 2.7e-07/0.7117, allocations: 0 / 0.8618 GB, free: 2.469 MB / 0.6387 GB
Notification: Performance of simCode: created initialization part: time 0.005959/0.7177, allocations: 3.101 MB / 0.8648 GB, free: 15.36 MB / 0.6544 GB
Notification: Performance of SimCode: time 0.009466/0.7272, allocations: 6.817 MB / 0.8715 GB, free: 8.5 MB / 0.6544 GB
Notification: Performance of Templates: time 0.08457/0.8117, allocations: 58.39 MB / 0.9285 GB, free: 14.73 MB / 0.7169 GB
make -j1 -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1.makefile
(rm -f IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1.sim & ./IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Examples.Performance.Example1v1.pipe 2>&1)