Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6.conf.json loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00124/0.00124, allocations: 103.6 kB / 18.05 MB, free: 4.309 MB / 14.72 MB [Timeout remaining time 90] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001236/0.001236, allocations: 189.8 kB / 21.17 MB, free: 1.199 MB / 14.72 MB [Timeout remaining time 90] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.353/1.353, allocations: 225.6 MB / 249.7 MB, free: 3.234 MB / 190.1 MB [Timeout remaining time 88] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo", uses=false) [Timeout 90] Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.8311/0.8311, allocations: 137.4 MB / 442.1 MB, free: 13.89 MB / 350.1 MB [Timeout remaining time 89] 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.FlowSystem.Simplified6,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6") translateModel(IDEAS.Fluid.Examples.FlowSystem.Simplified6,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6") [Timeout 660] Notification: Performance of FrontEnd - loaded program: time 0.001844/0.001844, allocations: 67.89 kB / 0.6135 GB, free: 1.406 MB / 0.4981 GB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3222/0.3241, allocations: 85.54 MB / 0.6971 GB, free: 14.91 MB / 0.5137 GB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pmpSouth.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pmpNorth.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pumpHea.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value. [/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pumpCoo.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.FlowSystem.Simplified6): time 0.6677/0.9918, allocations: 358.3 MB / 1.047 GB, free: 11.93 MB / 0.7325 GB Notification: Performance of NFInst.instExpressions: time 0.1073/1.099, allocations: 72.98 MB / 1.118 GB, free: 2.77 MB / 0.795 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.01301/1.112, allocations: 433.4 kB / 1.119 GB, free: 2.344 MB / 0.795 GB Notification: Performance of NFTyping.typeComponents: time 0.01335/1.125, allocations: 4.783 MB / 1.123 GB, free: 13.54 MB / 0.8106 GB Notification: Performance of NFTyping.typeBindings: time 0.03059/1.156, allocations: 11.61 MB / 1.135 GB, free: 1.883 MB / 0.8106 GB Notification: Performance of NFTyping.typeClassSections: time 0.01939/1.175, allocations: 7.974 MB / 1.142 GB, free: 9.969 MB / 0.8262 GB Notification: Performance of NFFlatten.flatten: time 0.03916/1.215, allocations: 29.22 MB / 1.171 GB, free: 12.66 MB / 0.8575 GB Notification: Performance of NFFlatten.resolveConnections: time 0.02246/1.237, allocations: 13.97 MB / 1.185 GB, free: 14.54 MB / 0.8731 GB Notification: Performance of NFEvalConstants.evaluate: time 0.02752/1.265, allocations: 12.97 MB / 1.197 GB, free: 1.551 MB / 0.8731 GB Notification: Performance of NFSimplifyModel.simplify: time 0.8069/2.071, allocations: 10.23 MB / 1.207 GB, free: 42.66 MB / 0.8732 GB Notification: Performance of NFPackage.collectConstants: time 0.0048/2.076, allocations: 1.051 MB / 1.208 GB, free: 42.66 MB / 0.8732 GB Notification: Performance of NFFlatten.collectFunctions: time 0.01487/2.091, allocations: 4.361 MB / 1.213 GB, free: 42.66 MB / 0.8732 GB Notification: Performance of NFScalarize.scalarize: time 0.006492/2.098, allocations: 3.716 MB / 1.216 GB, free: 42.66 MB / 0.8732 GB Notification: Performance of NFVerifyModel.verify: time 0.01593/2.114, allocations: 7.436 MB / 1.224 GB, free: 40.67 MB / 0.8732 GB Notification: Performance of NFConvertDAE.convert: time 0.03019/2.144, allocations: 19.6 MB / 1.243 GB, free: 37.61 MB / 0.8732 GB Notification: Performance of FrontEnd - DAE generated: time 3.657e-06/2.144, allocations: 1.406 kB / 1.243 GB, free: 37.61 MB / 0.8732 GB Notification: Performance of FrontEnd: time 9.92e-07/2.144, allocations: 0 / 1.243 GB, free: 37.61 MB / 0.8732 GB Notification: Performance of Transformations before backend: time 0.0007673/2.145, allocations: 0 / 1.243 GB, free: 37.61 MB / 0.8732 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 1521 * Number of variables: 1521 Notification: Performance of Generate backend data structure: time 0.04131/2.186, allocations: 15.86 MB / 1.258 GB, free: 30.73 MB / 0.8732 GB Notification: Performance of prepare preOptimizeDAE: time 5.138e-05/2.186, allocations: 9.734 kB / 1.258 GB, free: 30.73 MB / 0.8732 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01045/2.196, allocations: 2.209 MB / 1.26 GB, free: 29.86 MB / 0.8732 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.0255/2.222, allocations: 11.99 MB / 1.272 GB, free: 27.44 MB / 0.8732 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006197/2.222, allocations: 0.5132 MB / 1.273 GB, free: 27.43 MB / 0.8732 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.003287/2.226, allocations: 0.6772 MB / 1.273 GB, free: 27.43 MB / 0.8732 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.02096/2.247, allocations: 8.99 MB / 1.282 GB, free: 26.31 MB / 0.8732 GB Notification: Performance of preOpt findStateOrder (simulation): time 0.0002407/2.247, allocations: 26.97 kB / 1.282 GB, free: 26.3 MB / 0.8732 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001825/2.249, allocations: 249.5 kB / 1.282 GB, free: 26.3 MB / 0.8732 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.000141/2.249, allocations: 154.4 kB / 1.282 GB, free: 26.3 MB / 0.8732 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01474/2.264, allocations: 7.382 MB / 1.29 GB, free: 26.23 MB / 0.8732 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.06311/2.327, allocations: 49.15 MB / 1.338 GB, free: 12.53 MB / 0.8888 GB Notification: Performance of preOpt comSubExp (simulation): time 0.008873/2.336, allocations: 5.025 MB / 1.342 GB, free: 11.65 MB / 0.8888 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.005811/2.341, allocations: 3.594 MB / 1.346 GB, free: 11.03 MB / 0.8888 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 evalFunc (simulation): time 0.02788/2.369, allocations: 13.07 MB / 1.359 GB, free: 4.688 MB / 0.8888 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.006834/2.376, allocations: 3.675 MB / 1.362 GB, free: 2.039 MB / 0.8888 GB Notification: Performance of preOpt simplifyInStream (simulation): time 0.007813/2.384, allocations: 1.437 MB / 1.364 GB, free: 0.7734 MB / 0.8888 GB Notification: Performance of pre-optimization done (n=316): time 1.272e-05/2.384, allocations: 0 / 1.364 GB, free: 0.7734 MB / 0.8888 GB Notification: Performance of matching and sorting (n=502): time 0.1821/2.566, allocations: 54.49 MB / 1.417 GB, free: 15.55 MB / 0.9513 GB Notification: Performance of inlineWhenForInitialization (initialization): time 8.632e-05/2.566, allocations: 103.3 kB / 1.417 GB, free: 15.43 MB / 0.9513 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02616/2.592, allocations: 12.89 MB / 1.43 GB, free: 2.609 MB / 0.9513 GB Notification: Performance of collectPreVariables (initialization): time 0.001905/2.594, allocations: 163.6 kB / 1.43 GB, free: 2.445 MB / 0.9513 GB Notification: Performance of collectInitialEqns (initialization): time 0.008242/2.602, allocations: 6.224 MB / 1.436 GB, free: 12.23 MB / 0.9669 GB Notification: Performance of collectInitialBindings (initialization): time 0.002818/2.605, allocations: 1.778 MB / 1.438 GB, free: 10.48 MB / 0.9669 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.005557/2.611, allocations: 1.75 MB / 1.439 GB, free: 8.727 MB / 0.9669 GB Notification: Performance of setup shared object (initialization): time 0.000136/2.611, allocations: 304.3 kB / 1.44 GB, free: 8.43 MB / 0.9669 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.01292/2.624, allocations: 5.879 MB / 1.445 GB, free: 2.539 MB / 0.9669 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01577/2.64, allocations: 8.437 MB / 1.454 GB, free: 9.031 MB / 0.9826 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.02842/2.668, allocations: 13.65 MB / 1.467 GB, free: 10.72 MB / 0.9982 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.977e-05/2.668, allocations: 30.44 kB / 1.467 GB, free: 10.7 MB / 0.9982 GB Notification: Performance of matching and sorting (n=950) (initialization): time 0.04821/2.716, allocations: 18.86 MB / 1.485 GB, free: 8.223 MB / 1.014 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001123/2.716, allocations: 57.7 kB / 1.485 GB, free: 8.16 MB / 1.014 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001072/2.717, allocations: 65.02 kB / 1.485 GB, free: 8.098 MB / 1.014 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01719/2.734, allocations: 4.857 MB / 1.49 GB, free: 3.262 MB / 1.014 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01129/2.745, allocations: 2.014 MB / 1.492 GB, free: 1.336 MB / 1.014 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01894/2.764, allocations: 14.44 MB / 1.506 GB, free: 2.508 MB / 1.029 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01316/2.777, allocations: 0.8147 MB / 1.507 GB, free: 1.695 MB / 1.029 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001927/2.779, allocations: 495.7 kB / 1.508 GB, free: 1.211 MB / 1.029 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01893/2.798, allocations: 8.122 MB / 1.515 GB, free: 9.078 MB / 1.045 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01535/2.813, allocations: 7.993 MB / 1.523 GB, free: 16 kB / 1.045 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02689/2.84, allocations: 12.76 MB / 1.536 GB, free: 2.602 MB / 1.061 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.427e-05/2.84, allocations: 20.06 kB / 1.536 GB, free: 2.582 MB / 1.061 GB Notification: Performance of matching and sorting (n=950) (initialization_lambda0): time 0.04828/2.889, allocations: 17.43 MB / 1.553 GB, free: 1.508 MB / 1.076 GB Notification: Performance of prepare postOptimizeDAE: time 0.0001081/2.889, allocations: 60.58 kB / 1.553 GB, free: 1.445 MB / 1.076 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.88e-05/2.889, allocations: 64 kB / 1.553 GB, free: 1.383 MB / 1.076 GB Notification: Performance of postOpt tearingSystem (initialization): time 0.01427/2.903, allocations: 4.536 MB / 1.557 GB, free: 12.84 MB / 1.092 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0104/2.913, allocations: 1.991 MB / 1.559 GB, free: 10.93 MB / 1.092 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02967/2.943, allocations: 19.16 MB / 1.578 GB, free: 7.238 MB / 1.108 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0129/2.956, allocations: 0.8409 MB / 1.579 GB, free: 6.395 MB / 1.108 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001945/2.958, allocations: 459.7 kB / 1.579 GB, free: 5.945 MB / 1.108 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 273 * Number of states: 0 () * Number of discrete variables: 10 ($whenCondition1,stepValve.count,$PRE.stepValve.count,stepValve.T_start,$PRE.stepValve.T_start,pumpHea.stage,stepPump.pulseStart,$PRE.stepPump.pulseStart,stepPump.y,$whenCondition2) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (739): * Single equations (assignments): 724 * Array equations: 4 * Algorithm blocks: 1 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 6 * Torn equation systems: 4 * Mixed (continuous/discrete) equation systems: 0 Notification: Equation system details (not torn): * Constant Jacobian (size): 0 systems * Linear Jacobian (size,density): 0 systems * Non-linear Jacobian (size): 6 systems {1, 1, 1, 1, 1, 1} * Without analytic Jacobian (size): 0 systems Notification: Torn system details for strict tearing set: * Linear torn systems (#iteration vars, #inner vars, density): 2 systems {(1,3,100.0%), (1,3,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 2 systems {(5,80), (5,80)} Notification: Performance of prepare postOptimizeDAE: time 0.003179/2.961, allocations: 0.6225 MB / 1.58 GB, free: 5.414 MB / 1.108 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004209/2.965, allocations: 1.273 MB / 1.581 GB, free: 4.133 MB / 1.108 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.3661/3.331, allocations: 14.91 MB / 1.596 GB, free: 0.532 GB / 1.108 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.02436/3.356, allocations: 12.01 MB / 1.607 GB, free: 0.5294 GB / 1.108 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.518e-05/3.356, allocations: 0 / 1.607 GB, free: 0.5294 GB / 1.108 GB Notification: Performance of postOpt removeConstants (simulation): time 0.00566/3.362, allocations: 2.206 MB / 1.61 GB, free: 0.5289 GB / 1.108 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003181/3.365, allocations: 105.7 kB / 1.61 GB, free: 0.5289 GB / 1.108 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008953/3.374, allocations: 0.6597 MB / 1.61 GB, free: 0.5288 GB / 1.108 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001197/3.375, allocations: 0.5641 MB / 1.611 GB, free: 0.5287 GB / 1.108 GB Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.03115/3.406, allocations: 13.17 MB / 1.624 GB, free: 0.5254 GB / 1.108 GB Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.03028/3.436, allocations: 17 MB / 1.64 GB, free: 0.5204 GB / 1.108 GB Notification: Performance of postOpt setEvaluationStage (simulation): time 0.008082/3.444, allocations: 4.647 MB / 1.645 GB, free: 0.5191 GB / 1.108 GB Notification: Performance of sorting global known variables: time 0.01376/3.458, allocations: 8.738 MB / 1.653 GB, free: 0.5163 GB / 1.108 GB Notification: Performance of Backend: time 2.4e-07/3.458, allocations: 0 / 1.653 GB, free: 0.5163 GB / 1.108 GB Notification: Performance of simCode: created initialization part: time 0.04063/3.499, allocations: 17.34 MB / 1.67 GB, free: 0.501 GB / 1.108 GB Notification: Performance of SimCode: time 0.0461/3.545, allocations: 28.76 MB / 1.698 GB, free: 484.7 MB / 1.108 GB Notification: Performance of Templates: time 0.3483/3.893, allocations: 307.2 MB / 1.998 GB, free: 179.3 MB / 1.108 GB [Timeout remaining time 656] make -j1 -f IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6.makefile [Timeout 660] (rm -f IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6.sim & ./IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6 -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified6.pipe 2>&1) [Timeout 480]