Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified.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.001225/0.001225, allocations: 105.2 kB / 18.05 MB, free: 4.32 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.001251/0.001251, allocations: 186 kB / 21.17 MB, free: 1.211 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.352/1.352, allocations: 225.6 MB / 249.7 MB, free: 3.246 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.849/0.849, allocations: 137.4 MB / 442.2 MB, free: 13.88 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.Movers.Validation.PowerSimplified,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified")
translateModel(IDEAS.Fluid.Movers.Validation.PowerSimplified,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified") [Timeout 660]
Notification: Performance of FrontEnd - loaded program: time 0.001874/0.001874, allocations: 67.89 kB / 0.6134 GB, free: 1.57 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3319/0.3338, allocations: 85.53 MB / 0.6969 GB, free: 14.94 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 pump_dp.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 pump_m_flow.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.Movers.Validation.PowerSimplified): time 0.08022/0.414, allocations: 74.89 MB / 0.77 GB, free: 5.879 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.03458/0.4486, allocations: 23.66 MB / 0.7931 GB, free: 14.15 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003406/0.452, allocations: 119.3 kB / 0.7933 GB, free: 14.04 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.004373/0.4564, allocations: 1.705 MB / 0.7949 GB, free: 12.32 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.00964/0.466, allocations: 4.056 MB / 0.7989 GB, free: 8.254 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007169/0.4732, allocations: 3.144 MB / 0.802 GB, free: 5.125 MB / 0.6075 GB
Notification: Performance of NFFlatten.flatten: time 0.01185/0.485, allocations: 8.349 MB / 0.8101 GB, free: 12.75 MB / 0.6231 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003718/0.4887, allocations: 2.407 MB / 0.8125 GB, free: 10.28 MB / 0.6231 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006574/0.4953, allocations: 3.326 MB / 0.8157 GB, free: 6.953 MB / 0.6231 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003895/0.4992, allocations: 2.513 MB / 0.8182 GB, free: 4.43 MB / 0.6231 GB
Notification: Performance of NFPackage.collectConstants: time 0.000567/0.4998, allocations: 304 kB / 0.8184 GB, free: 4.133 MB / 0.6231 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004626/0.5044, allocations: 2.285 MB / 0.8207 GB, free: 1.844 MB / 0.6231 GB
Notification: Performance of NFScalarize.scalarize: time 0.001257/0.5056, allocations: 1.261 MB / 0.8219 GB, free: 0.5781 MB / 0.6231 GB
Notification: Performance of NFVerifyModel.verify: time 0.002309/0.508, allocations: 1.994 MB / 0.8239 GB, free: 14.57 MB / 0.6387 GB
Notification: Performance of NFConvertDAE.convert: time 0.008116/0.5161, allocations: 6.068 MB / 0.8298 GB, free: 8.484 MB / 0.6387 GB
Notification: Performance of FrontEnd - DAE generated: time 4.018e-06/0.5161, allocations: 3.938 kB / 0.8298 GB, free: 8.48 MB / 0.6387 GB
Notification: Performance of FrontEnd: time 3.146e-06/0.5161, allocations: 3.984 kB / 0.8298 GB, free: 8.477 MB / 0.6387 GB
Notification: Performance of Transformations before backend: time 6.958e-05/0.5162, allocations: 4 kB / 0.8298 GB, free: 8.473 MB / 0.6387 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 440
 * Number of variables: 440
Notification: Performance of Generate backend data structure: time 0.007364/0.5235, allocations: 4.476 MB / 0.8342 GB, free: 3.922 MB / 0.6387 GB
Notification: Performance of prepare preOptimizeDAE: time 4.079e-05/0.5236, allocations: 13.69 kB / 0.8342 GB, free: 3.91 MB / 0.6387 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002884/0.5264, allocations: 0.6542 MB / 0.8348 GB, free: 3.254 MB / 0.6387 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006098/0.5325, allocations: 3.468 MB / 0.8382 GB, free: 15.73 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001283/0.5327, allocations: 143.5 kB / 0.8383 GB, free: 15.59 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003021/0.533, allocations: 199.9 kB / 0.8385 GB, free: 15.39 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003948/0.5369, allocations: 2.181 MB / 0.8407 GB, free: 13.13 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.826e-05/0.537, allocations: 0 / 0.8407 GB, free: 13.13 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001778/0.5371, allocations: 80 kB / 0.8407 GB, free: 13.05 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.999e-05/0.5372, allocations: 44 kB / 0.8408 GB, free: 13.01 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003356/0.5405, allocations: 1.582 MB / 0.8423 GB, free: 11.42 MB / 0.6544 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.01314/0.5537, allocations: 9.838 MB / 0.8519 GB, free: 1.086 MB / 0.6544 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002761/0.5564, allocations: 1.127 MB / 0.853 GB, free: 15.95 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0012/0.5576, allocations: 0.5646 MB / 0.8536 GB, free: 15.38 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.004956/0.5626, allocations: 3.497 MB / 0.857 GB, free: 11.59 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.243e-05/0.5626, allocations: 39.22 kB / 0.857 GB, free: 11.54 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=82): time 2.004e-06/0.5626, allocations: 0 / 0.857 GB, free: 11.54 MB / 0.67 GB
Notification: Performance of matching and sorting (n=90): time 0.009154/0.5718, allocations: 4.098 MB / 0.861 GB, free: 7.367 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.276e-05/0.5718, allocations: 60.41 kB / 0.8611 GB, free: 7.293 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004694/0.5765, allocations: 3.474 MB / 0.8645 GB, free: 3.84 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001326/0.5767, allocations: 49.7 kB / 0.8645 GB, free: 3.785 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001464/0.5781, allocations: 1.617 MB / 0.8661 GB, free: 2.156 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0003304/0.5784, allocations: 337.1 kB / 0.8664 GB, free: 1.824 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005154/0.579, allocations: 351.4 kB / 0.8668 GB, free: 1.473 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 0.000126/0.5791, allocations: 313.1 kB / 0.8671 GB, free: 1.164 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001548/0.5806, allocations: 0.8244 MB / 0.8679 GB, free: 344 kB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.2841/0.8647, allocations: 1.472 MB / 0.8693 GB, free: 156.4 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003107/0.8678, allocations: 2.276 MB / 0.8715 GB, free: 155.7 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.215e-05/0.8678, allocations: 5.344 kB / 0.8715 GB, free: 155.7 MB / 0.67 GB
Notification: Performance of matching and sorting (n=192) (initialization): time 0.004761/0.8726, allocations: 2.786 MB / 0.8743 GB, free: 154.8 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 2.884e-05/0.8726, allocations: 14.53 kB / 0.8743 GB, free: 154.8 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.674e-05/0.8726, allocations: 18 kB / 0.8743 GB, free: 154.8 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000805/0.8734, allocations: 396 kB / 0.8747 GB, free: 154.7 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001354/0.8748, allocations: 361.1 kB / 0.875 GB, free: 154.6 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003598/0.8784, allocations: 6.183 MB / 0.8811 GB, free: 149 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002018/0.8804, allocations: 87.86 kB / 0.8811 GB, free: 149 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002294/0.8806, allocations: 103.8 kB / 0.8812 GB, free: 149 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002469/0.8831, allocations: 1.411 MB / 0.8826 GB, free: 148.4 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001379/0.8845, allocations: 1.324 MB / 0.8839 GB, free: 147.3 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002149/0.8866, allocations: 1.987 MB / 0.8858 GB, free: 146 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.041e-05/0.8866, allocations: 9.156 kB / 0.8859 GB, free: 146 MB / 0.67 GB
Notification: Performance of matching and sorting (n=192) (initialization_lambda0): time 0.003708/0.8904, allocations: 2.505 MB / 0.8883 GB, free: 145.2 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 1.66e-05/0.8904, allocations: 11.88 kB / 0.8883 GB, free: 145.2 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.544e-05/0.8904, allocations: 15.75 kB / 0.8883 GB, free: 145.2 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009591/0.8913, allocations: 477.9 kB / 0.8888 GB, free: 145.1 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008986/0.8922, allocations: 320.1 kB / 0.8891 GB, free: 145.1 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007255/0.8995, allocations: 9.62 MB / 0.8985 GB, free: 137.8 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001981/0.9015, allocations: 73.95 kB / 0.8986 GB, free: 137.8 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001442/0.9016, allocations: 96.97 kB / 0.8986 GB, free: 137.7 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 81
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (171):
 * Single equations (assignments): 163
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 1
 * 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): 1 system
   {1}
 * Without analytic Jacobian (size): 0 systems
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): 4 systems
   {(1,2), (1,2), (1,2), (1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004808/0.9021, allocations: 292.2 kB / 0.8989 GB, free: 137.5 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0004072/0.9025, allocations: 334.1 kB / 0.8992 GB, free: 137.5 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00333/0.9058, allocations: 1.936 MB / 0.9011 GB, free: 136.7 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002353/0.9082, allocations: 1.65 MB / 0.9027 GB, free: 135.7 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.26e-06/0.9082, allocations: 9.141 kB / 0.9028 GB, free: 135.7 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007203/0.9089, allocations: 0.5484 MB / 0.9033 GB, free: 135.2 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003212/0.9092, allocations: 27.81 kB / 0.9033 GB, free: 135.2 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001144/0.9104, allocations: 55.5 kB / 0.9034 GB, free: 135.2 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000132/0.9105, allocations: 75.7 kB / 0.9034 GB, free: 135.1 MB / 0.67 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002992/0.9135, allocations: 1.579 MB / 0.905 GB, free: 134.3 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003501/0.917, allocations: 2.5 MB / 0.9074 GB, free: 132.1 MB / 0.67 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009657/0.918, allocations: 0.5816 MB / 0.908 GB, free: 131.6 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.002568/0.9205, allocations: 2.395 MB / 0.9103 GB, free: 129.2 MB / 0.67 GB
Notification: Performance of Backend: time 2.31e-07/0.9205, allocations: 4.094 kB / 0.9103 GB, free: 129.2 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.006799/0.9273, allocations: 3.808 MB / 0.9141 GB, free: 125.5 MB / 0.67 GB
Notification: Performance of SimCode: time 0.01055/0.9379, allocations: 7.619 MB / 0.9215 GB, free: 117.9 MB / 0.67 GB
Notification: Performance of Templates: time 0.09387/1.032, allocations: 79.67 MB / 0.9993 GB, free: 38.89 MB / 0.67 GB
[Timeout remaining time 659]
make -j1 -f IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified.sim & ./IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Movers.Validation.PowerSimplified.pipe 2>&1) [Timeout 480]