Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives.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.001252/0.001252, allocations: 105.3 kB / 18.05 MB, free: 4.289 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.001299/0.001299, allocations: 193.8 kB / 21.17 MB, free: 1.18 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.347/1.347, allocations: 225.6 MB / 249.7 MB, free: 3.289 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.8099/0.8099, allocations: 137.4 MB / 442.1 MB, free: 13.76 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.PumpCurveDerivatives,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives")
translateModel(IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives,tolerance=1e-06,outputFormat="empty",numberOfIntervals=500,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives") [Timeout 660]
Notification: Performance of FrontEnd - loaded program: time 0.001863/0.001863, allocations: 63.89 kB / 0.6134 GB, free: 1.609 MB / 0.4981 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3316/0.3335, allocations: 85.53 MB / 0.6969 GB, free: 15.15 MB / 0.5138 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter forcedPump1.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.PumpCurveDerivatives): time 0.08205/0.4155, allocations: 78.61 MB / 0.7737 GB, free: 2.312 MB / 0.5763 GB
Notification: Performance of NFInst.instExpressions: time 0.03549/0.451, allocations: 26.02 MB / 0.7991 GB, free: 8.223 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003564/0.4546, allocations: 119.4 kB / 0.7992 GB, free: 8.105 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.004334/0.4589, allocations: 1.665 MB / 0.8008 GB, free: 6.434 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.008765/0.4677, allocations: 3.576 MB / 0.8043 GB, free: 2.844 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006844/0.4745, allocations: 2.995 MB / 0.8072 GB, free: 15.86 MB / 0.6231 GB
Notification: Performance of NFFlatten.flatten: time 0.009884/0.4844, allocations: 7.004 MB / 0.8141 GB, free: 8.848 MB / 0.6231 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003482/0.4879, allocations: 2.191 MB / 0.8162 GB, free: 6.594 MB / 0.6231 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006324/0.4942, allocations: 3.03 MB / 0.8192 GB, free: 3.562 MB / 0.6231 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003705/0.4979, allocations: 2.35 MB / 0.8215 GB, free: 1.203 MB / 0.6231 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005649/0.4985, allocations: 312 kB / 0.8218 GB, free: 0.8984 MB / 0.6231 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004315/0.5028, allocations: 2.211 MB / 0.8239 GB, free: 14.68 MB / 0.6388 GB
Notification: Performance of NFScalarize.scalarize: time 0.001269/0.5041, allocations: 1.312 MB / 0.8252 GB, free: 13.37 MB / 0.6388 GB
Notification: Performance of NFVerifyModel.verify: time 0.002202/0.5063, allocations: 1.986 MB / 0.8272 GB, free: 11.37 MB / 0.6388 GB
Notification: Performance of NFConvertDAE.convert: time 0.008339/0.5146, allocations: 6.138 MB / 0.8331 GB, free: 5.211 MB / 0.6388 GB
Notification: Performance of FrontEnd - DAE generated: time 4.248e-06/0.5146, allocations: 0 / 0.8331 GB, free: 5.211 MB / 0.6388 GB
Notification: Performance of FrontEnd: time 1.342e-06/0.5146, allocations: 0 / 0.8331 GB, free: 5.211 MB / 0.6388 GB
Notification: Performance of Transformations before backend: time 8.422e-05/0.5147, allocations: 0 / 0.8331 GB, free: 5.211 MB / 0.6388 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 397
 * Number of variables: 397
Notification: Performance of Generate backend data structure: time 0.008463/0.5232, allocations: 4.612 MB / 0.8377 GB, free: 0.5234 MB / 0.6388 GB
Notification: Performance of prepare preOptimizeDAE: time 4.346e-05/0.5232, allocations: 13.69 kB / 0.8377 GB, free: 0.5117 MB / 0.6388 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004694/0.5279, allocations: 0.9428 MB / 0.8386 GB, free: 15.57 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006926/0.5348, allocations: 3.79 MB / 0.8423 GB, free: 11.72 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001341/0.535, allocations: 135.1 kB / 0.8424 GB, free: 11.59 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003324/0.5353, allocations: 180 kB / 0.8426 GB, free: 11.41 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004679/0.54, allocations: 2.386 MB / 0.8449 GB, free: 8.934 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.072e-05/0.54, allocations: 7.938 kB / 0.8449 GB, free: 8.926 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001673/0.5402, allocations: 64 kB / 0.845 GB, free: 8.863 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.405e-05/0.5402, allocations: 40 kB / 0.845 GB, free: 8.824 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004638/0.5449, allocations: 1.866 MB / 0.8468 GB, free: 6.953 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.01524/0.5601, allocations: 10.65 MB / 0.8572 GB, free: 11.71 MB / 0.67 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004151/0.5642, allocations: 1.504 MB / 0.8587 GB, free: 10.2 MB / 0.67 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001823/0.5661, allocations: 0.7098 MB / 0.8594 GB, free: 9.484 MB / 0.67 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.005358/0.5714, allocations: 3.644 MB / 0.863 GB, free: 5.574 MB / 0.67 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.675e-05/0.5715, allocations: 43.22 kB / 0.863 GB, free: 5.523 MB / 0.67 GB
Notification: Performance of pre-optimization done (n=76): time 2.545e-06/0.5715, allocations: 4 kB / 0.863 GB, free: 5.52 MB / 0.67 GB
Notification: Performance of matching and sorting (n=76): time 0.007401/0.5789, allocations: 2.578 MB / 0.8655 GB, free: 2.91 MB / 0.67 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.465e-05/0.5789, allocations: 60.06 kB / 0.8656 GB, free: 2.84 MB / 0.67 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.3031/0.882, allocations: 3.73 MB / 0.8692 GB, free: 158 MB / 0.67 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003037/0.8823, allocations: 52.97 kB / 0.8693 GB, free: 158 MB / 0.67 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001156/0.8835, allocations: 1.598 MB / 0.8708 GB, free: 157.1 MB / 0.67 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002748/0.8838, allocations: 287.1 kB / 0.8711 GB, free: 157.1 MB / 0.67 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005755/0.8843, allocations: 391 kB / 0.8715 GB, free: 156.9 MB / 0.67 GB
Notification: Performance of setup shared object (initialization): time 3.912e-05/0.8844, allocations: 305.1 kB / 0.8718 GB, free: 156.6 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002532/0.8869, allocations: 1.257 MB / 0.873 GB, free: 156.2 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002832/0.8897, allocations: 1.98 MB / 0.8749 GB, free: 154.9 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005166/0.8949, allocations: 3.153 MB / 0.878 GB, free: 153.2 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.989e-05/0.8949, allocations: 5.906 kB / 0.878 GB, free: 153.2 MB / 0.67 GB
Notification: Performance of matching and sorting (n=202) (initialization): time 0.007415/0.9023, allocations: 3.637 MB / 0.8816 GB, free: 151.9 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 2.912e-05/0.9024, allocations: 13 kB / 0.8816 GB, free: 151.9 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.955e-05/0.9024, allocations: 21.69 kB / 0.8816 GB, free: 151.9 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006549/0.9031, allocations: 307.3 kB / 0.8819 GB, free: 151.9 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001618/0.9047, allocations: 437.9 kB / 0.8823 GB, free: 151.8 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0005877/0.9053, allocations: 0.8136 MB / 0.8831 GB, free: 151.2 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002439/0.9077, allocations: 293.7 kB / 0.8834 GB, free: 151.1 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001871/0.9079, allocations: 131.3 kB / 0.8835 GB, free: 151.1 MB / 0.67 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002686/0.9106, allocations: 1.737 MB / 0.8852 GB, free: 150.4 MB / 0.67 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0018/0.9124, allocations: 1.738 MB / 0.8869 GB, free: 149.1 MB / 0.67 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003276/0.9157, allocations: 2.695 MB / 0.8895 GB, free: 147.6 MB / 0.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.668e-06/0.9157, allocations: 7.938 kB / 0.8896 GB, free: 147.6 MB / 0.67 GB
Notification: Performance of matching and sorting (n=202) (initialization_lambda0): time 0.005293/0.921, allocations: 3.18 MB / 0.8927 GB, free: 146.4 MB / 0.67 GB
Notification: Performance of prepare postOptimizeDAE: time 1.97e-05/0.921, allocations: 15.5 kB / 0.8927 GB, free: 146.4 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.431e-05/0.921, allocations: 19.28 kB / 0.8927 GB, free: 146.4 MB / 0.67 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008991/0.9219, allocations: 392.9 kB / 0.8931 GB, free: 146.3 MB / 0.67 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001389/0.9233, allocations: 408.8 kB / 0.8935 GB, free: 146.2 MB / 0.67 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005223/0.9285, allocations: 5.019 MB / 0.8984 GB, free: 142.8 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002351/0.9309, allocations: 219.5 kB / 0.8986 GB, free: 142.7 MB / 0.67 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002208/0.9311, allocations: 122.6 kB / 0.8987 GB, free: 142.7 MB / 0.67 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 95
 * 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 (177):
 * Single equations (assignments): 173
 * Array equations: 3
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * 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): 1 system
   {(1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.0004827/0.9316, allocations: 288.3 kB / 0.899 GB, free: 142.4 MB / 0.67 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006666/0.9322, allocations: 330.8 kB / 0.8993 GB, free: 142.2 MB / 0.67 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00474/0.937, allocations: 2.264 MB / 0.9015 GB, free: 139.9 MB / 0.67 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.168e-05/0.937, allocations: 3.984 kB / 0.9015 GB, free: 139.9 MB / 0.67 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.917e-06/0.937, allocations: 0 / 0.9015 GB, free: 139.9 MB / 0.67 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00108/0.9381, allocations: 0.5808 MB / 0.9021 GB, free: 139.3 MB / 0.67 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005992/0.9387, allocations: 16 kB / 0.9021 GB, free: 139.3 MB / 0.67 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00181/0.9405, allocations: 123.9 kB / 0.9022 GB, free: 139.2 MB / 0.67 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000137/0.9406, allocations: 72.84 kB / 0.9023 GB, free: 139.1 MB / 0.67 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.004413/0.945, allocations: 1.891 MB / 0.9041 GB, free: 137.2 MB / 0.67 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.005348/0.9504, allocations: 3.022 MB / 0.9071 GB, free: 134.2 MB / 0.67 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001491/0.9519, allocations: 0.7339 MB / 0.9078 GB, free: 133.5 MB / 0.67 GB
Notification: Performance of sorting global known variables: time 0.003182/0.955, allocations: 2.566 MB / 0.9103 GB, free: 130.9 MB / 0.67 GB
Notification: Performance of Backend: time 3.61e-07/0.955, allocations: 0 / 0.9103 GB, free: 130.9 MB / 0.67 GB
Notification: Performance of simCode: created initialization part: time 0.008035/0.9631, allocations: 3.861 MB / 0.9141 GB, free: 127.2 MB / 0.67 GB
Notification: Performance of SimCode: time 0.01071/0.9738, allocations: 7.363 MB / 0.9212 GB, free: 119.8 MB / 0.67 GB
Notification: Performance of Templates: time 0.09458/1.068, allocations: 81.72 MB / 1.001 GB, free: 38.97 MB / 0.67 GB
[Timeout remaining time 659]
make -j1 -f IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives.makefile [Timeout 660]
(rm -f IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives.sim & ./IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.Movers.Validation.PumpCurveDerivatives.pipe 2>&1) [Timeout 480]