Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Examples.Performance.Example2.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.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Examples.Performance.Example2")
translateModel(IDEAS.Fluid.Examples.Performance.Example2,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.Examples.Performance.Example2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001331/0.001331, allocations: 114.5 kB / 16.42 MB, free: 6.496 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.001446/0.001446, allocations: 188.3 kB / 17.35 MB, free: 5.758 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.1 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.7695/0.7695, allocations: 132.2 MB / 423.4 MB, free: 6.57 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001226/0.001226, allocations: 63.03 kB / 0.582 GB, free: 23.78 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1361/0.1374, allocations: 80.21 MB / 0.6603 GB, free: 10.27 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_dp.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.Example2): time 0.02987/0.1673, allocations: 29.6 MB / 0.6892 GB, free: 12.56 MB / 0.5294 GB
Notification: Performance of NFInst.instExpressions: time 0.01359/0.1809, allocations: 9.903 MB / 0.6989 GB, free: 2.625 MB / 0.5294 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001473/0.1824, allocations: 51.69 kB / 0.699 GB, free: 2.574 MB / 0.5294 GB
Notification: Performance of NFTyping.typeComponents: time 0.00211/0.1845, allocations: 0.6797 MB / 0.6996 GB, free: 1.891 MB / 0.5294 GB
Notification: Performance of NFTyping.typeBindings: time 0.004207/0.1887, allocations: 1.496 MB / 0.7011 GB, free: 400 kB / 0.5294 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003422/0.1922, allocations: 1.384 MB / 0.7024 GB, free: 15.02 MB / 0.545 GB
Notification: Performance of NFFlatten.flatten: time 0.004842/0.197, allocations: 3.827 MB / 0.7062 GB, free: 11.18 MB / 0.545 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002114/0.1992, allocations: 1.361 MB / 0.7075 GB, free: 9.781 MB / 0.545 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003313/0.2025, allocations: 1.527 MB / 0.709 GB, free: 8.254 MB / 0.545 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001906/0.2044, allocations: 1.038 MB / 0.71 GB, free: 7.211 MB / 0.545 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004434/0.2049, allocations: 120 kB / 0.7101 GB, free: 7.094 MB / 0.545 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002635/0.2075, allocations: 1.135 MB / 0.7112 GB, free: 5.957 MB / 0.545 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006765/0.2082, allocations: 398.6 kB / 0.7116 GB, free: 5.566 MB / 0.545 GB
Notification: Performance of NFVerifyModel.verify: time 0.001603/0.2098, allocations: 0.7891 MB / 0.7124 GB, free: 4.773 MB / 0.545 GB
Notification: Performance of NFConvertDAE.convert: time 0.004474/0.2143, allocations: 2.46 MB / 0.7148 GB, free: 2.305 MB / 0.545 GB
Notification: Performance of FrontEnd - DAE generated: time 5.43e-06/0.2143, allocations: 0 / 0.7148 GB, free: 2.305 MB / 0.545 GB
Notification: Performance of FrontEnd: time 1.422e-06/0.2143, allocations: 0 / 0.7148 GB, free: 2.305 MB / 0.545 GB
Notification: Performance of Transformations before backend: time 7.715e-05/0.2144, allocations: 0 / 0.7148 GB, free: 2.305 MB / 0.545 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 188
 * Number of variables: 188
Notification: Performance of Generate backend data structure: time 0.003873/0.2183, allocations: 2.003 MB / 0.7167 GB, free: 248 kB / 0.545 GB
Notification: Performance of prepare preOptimizeDAE: time 4.049e-05/0.2183, allocations: 8.031 kB / 0.7167 GB, free: 240 kB / 0.545 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001141/0.2195, allocations: 257.2 kB / 0.717 GB, free: 15.98 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002382/0.2219, allocations: 1.362 MB / 0.7183 GB, free: 14.57 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.401e-05/0.2219, allocations: 62 kB / 0.7184 GB, free: 14.51 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001281/0.2221, allocations: 84 kB / 0.7185 GB, free: 14.43 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001583/0.2237, allocations: 0.9811 MB / 0.7194 GB, free: 13.39 MB / 0.5606 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.305e-05/0.2237, allocations: 0 / 0.7194 GB, free: 13.39 MB / 0.5606 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.577e-05/0.2238, allocations: 39.88 kB / 0.7195 GB, free: 13.35 MB / 0.5606 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.746e-05/0.2238, allocations: 20 kB / 0.7195 GB, free: 13.33 MB / 0.5606 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00139/0.2252, allocations: 0.7025 MB / 0.7202 GB, free: 12.62 MB / 0.5606 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.005354/0.2306, allocations: 4.849 MB / 0.7249 GB, free: 7.445 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001164/0.2317, allocations: 0.5544 MB / 0.7254 GB, free: 6.883 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005909/0.2323, allocations: 313.3 kB / 0.7257 GB, free: 6.574 MB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.002036/0.2344, allocations: 1.584 MB / 0.7273 GB, free: 4.84 MB / 0.5606 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00065/0.2351, allocations: 332 kB / 0.7276 GB, free: 4.504 MB / 0.5606 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.0002349/0.2353, allocations: 51.66 kB / 0.7277 GB, free: 4.453 MB / 0.5606 GB
Notification: Performance of pre-optimization done (n=43): time 2.043e-06/0.2353, allocations: 0 / 0.7277 GB, free: 4.453 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=43): time 0.002973/0.2383, allocations: 1.173 MB / 0.7288 GB, free: 3.25 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.955e-05/0.2383, allocations: 59.41 kB / 0.7289 GB, free: 3.18 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001451/0.2398, allocations: 1.286 MB / 0.7301 GB, free: 1.879 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 5.231e-05/0.2399, allocations: 41.7 kB / 0.7302 GB, free: 1.832 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004938/0.2404, allocations: 0.6578 MB / 0.7308 GB, free: 1.168 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001189/0.2405, allocations: 154.7 kB / 0.7309 GB, free: 1.016 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002063/0.2407, allocations: 158.2 kB / 0.7311 GB, free: 0.8555 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 0.0001106/0.2408, allocations: 334 kB / 0.7314 GB, free: 0.5234 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005504/0.2414, allocations: 271.6 kB / 0.7317 GB, free: 264 kB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007491/0.2421, allocations: 0.5865 MB / 0.7322 GB, free: 15.52 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00124/0.2434, allocations: 0.8097 MB / 0.733 GB, free: 14.59 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.801e-06/0.2434, allocations: 4 kB / 0.733 GB, free: 14.59 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=84) (initialization): time 0.002089/0.2455, allocations: 1.102 MB / 0.7341 GB, free: 13.47 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 3.722e-05/0.2455, allocations: 39.52 kB / 0.7342 GB, free: 13.43 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.176e-05/0.2456, allocations: 8 kB / 0.7342 GB, free: 13.42 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006165/0.2462, allocations: 188.7 kB / 0.7343 GB, free: 13.23 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005272/0.2467, allocations: 143.7 kB / 0.7345 GB, free: 13.09 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0006847/0.2474, allocations: 0.763 MB / 0.7352 GB, free: 12.3 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006712/0.2481, allocations: 48.62 kB / 0.7353 GB, free: 12.26 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.537e-05/0.2482, allocations: 43.92 kB / 0.7353 GB, free: 12.21 MB / 0.5762 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0008692/0.2491, allocations: 0.5561 MB / 0.7359 GB, free: 11.66 MB / 0.5762 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0006305/0.2497, allocations: 0.5553 MB / 0.7364 GB, free: 10.95 MB / 0.5762 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001016/0.2507, allocations: 0.7433 MB / 0.7371 GB, free: 10.1 MB / 0.5762 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.066e-06/0.2507, allocations: 0 / 0.7371 GB, free: 10.1 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=84) (initialization_lambda0): time 0.001685/0.2524, allocations: 1.058 MB / 0.7382 GB, free: 9.004 MB / 0.5762 GB
Notification: Performance of prepare postOptimizeDAE: time 2.967e-05/0.2525, allocations: 33.7 kB / 0.7382 GB, free: 8.965 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.885e-06/0.2525, allocations: 8.531 kB / 0.7382 GB, free: 8.957 MB / 0.5762 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001988/0.2527, allocations: 116.7 kB / 0.7383 GB, free: 8.84 MB / 0.5762 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004748/0.2532, allocations: 135.7 kB / 0.7384 GB, free: 8.707 MB / 0.5762 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002028/0.2552, allocations: 2.35 MB / 0.7407 GB, free: 6.203 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006357/0.2559, allocations: 48.69 kB / 0.7408 GB, free: 6.156 MB / 0.5762 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.723e-05/0.2559, allocations: 39.98 kB / 0.7408 GB, free: 6.117 MB / 0.5762 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 34
 * Number of states: 0 ()
 * Number of discrete variables: 7 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,nRes.y,from_dp.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (71):
 * Single equations (assignments): 68
 * Array equations: 1
 * Algorithm blocks: 1
 * 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
   {(5,7)}
Notification: Performance of prepare postOptimizeDAE: time 0.000233/0.2562, allocations: 224.1 kB / 0.741 GB, free: 5.891 MB / 0.5762 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001586/0.2563, allocations: 135.2 kB / 0.7412 GB, free: 5.758 MB / 0.5762 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001819/0.2582, allocations: 0.8815 MB / 0.742 GB, free: 4.867 MB / 0.5762 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001303/0.2595, allocations: 0.8648 MB / 0.7429 GB, free: 3.93 MB / 0.5762 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.889e-06/0.2595, allocations: 112 / 0.7429 GB, free: 3.93 MB / 0.5762 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003519/0.2599, allocations: 264.1 kB / 0.7431 GB, free: 3.652 MB / 0.5762 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001323/0.26, allocations: 15.94 kB / 0.7431 GB, free: 3.637 MB / 0.5762 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004674/0.2605, allocations: 27.97 kB / 0.7432 GB, free: 3.609 MB / 0.5762 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001076/0.2606, allocations: 48.36 kB / 0.7432 GB, free: 3.562 MB / 0.5762 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001728/0.2623, allocations: 0.8047 MB / 0.744 GB, free: 2.746 MB / 0.5762 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001765/0.2641, allocations: 1.118 MB / 0.7451 GB, free: 1.605 MB / 0.5762 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0005012/0.2646, allocations: 267.3 kB / 0.7453 GB, free: 1.344 MB / 0.5762 GB
Notification: Performance of sorting global known variables: time 0.001078/0.2657, allocations: 0.8896 MB / 0.7462 GB, free: 464 kB / 0.5762 GB
Notification: Performance of Backend: time 2.5e-07/0.2657, allocations: 4 kB / 0.7462 GB, free: 460 kB / 0.5762 GB
Notification: Performance of simCode: created initialization part: time 0.2775/0.5432, allocations: 1.527 MB / 0.7477 GB, free: 82.61 MB / 0.5762 GB
Notification: Performance of SimCode: time 0.004812/0.548, allocations: 3.2 MB / 0.7508 GB, free: 81.24 MB / 0.5762 GB
Notification: Performance of Templates: time 0.04289/0.591, allocations: 28.12 MB / 0.7783 GB, free: 71.01 MB / 0.5762 GB
make -j1 -f IDEAS_IDEAS.Fluid.Examples.Performance.Example2.makefile
(rm -f IDEAS_IDEAS.Fluid.Examples.Performance.Example2.pipe ; mkfifo IDEAS_IDEAS.Fluid.Examples.Performance.Example2.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Examples.Performance.Example2.pipe >> ../files/IDEAS_IDEAS.Fluid.Examples.Performance.Example2.sim & ./IDEAS_IDEAS.Fluid.Examples.Performance.Example2  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IDEAS_IDEAS.Fluid.Examples.Performance.Example2.pipe 2>&1)