Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_IDEAS.Fluid.Examples.Performance.Example4.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: "" <> buildModelFMU(IDEAS.Fluid.Examples.Performance.Example4,fileNamePrefix="IDEAS_IDEAS_Fluid_Examples_Performance_Example4",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Fluid.Examples.Performance.Example4,fileNamePrefix="IDEAS_IDEAS_Fluid_Examples_Performance_Example4",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008334/0.0008381, allocations: 91.61 kB / 15.06 MB, free: 1.098 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.0009136/0.0009138, allocations: 172.7 kB / 15.95 MB, free: 204 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.377/1.377, allocations: 223.3 MB / 240 MB, free: 5.406 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.8352/0.8352, allocations: 132.3 MB / 423.4 MB, free: 2.031 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.000423/0.0004231, allocations: 8 kB / 0.5035 GB, free: 4.129 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4182/0.4186, allocations: 81.58 MB / 0.5832 GB, free: 3.832 MB / 430.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Examples.Performance.Example4): time 0.2256/0.6443, allocations: 216.6 MB / 0.7947 GB, free: 7.215 MB / 0.6231 GB
Notification: Performance of NFInst.instExpressions: time 0.01892/0.6633, allocations: 14.72 MB / 0.8091 GB, free: 8.457 MB / 0.6387 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002114/0.6654, allocations: 55.56 kB / 0.8091 GB, free: 8.402 MB / 0.6387 GB
Notification: Performance of NFTyping.typeComponents: time 0.002364/0.6678, allocations: 0.6559 MB / 0.8098 GB, free: 7.742 MB / 0.6387 GB
Notification: Performance of NFTyping.typeBindings: time 0.006225/0.674, allocations: 2.129 MB / 0.8119 GB, free: 5.605 MB / 0.6387 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003832/0.6779, allocations: 1.25 MB / 0.8131 GB, free: 4.379 MB / 0.6387 GB
Notification: Performance of NFFlatten.flatten: time 0.005366/0.6833, allocations: 3.96 MB / 0.817 GB, free: 420 kB / 0.6387 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.347/1.03, allocations: 0.9312 MB / 0.8179 GB, free: 10.53 MB / 0.6387 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005308/1.036, allocations: 1.914 MB / 0.8197 GB, free: 10.52 MB / 0.6387 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002391/1.038, allocations: 1.01 MB / 0.8207 GB, free: 10.51 MB / 0.6387 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002963/1.038, allocations: 46.38 kB / 0.8208 GB, free: 10.51 MB / 0.6387 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004937/1.043, allocations: 1.906 MB / 0.8226 GB, free: 10.51 MB / 0.6387 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006152/1.044, allocations: 397.2 kB / 0.823 GB, free: 10.51 MB / 0.6387 GB
Notification: Performance of NFVerifyModel.verify: time 0.0006337/1.045, allocations: 332 kB / 0.8233 GB, free: 10.48 MB / 0.6387 GB
Notification: Performance of NFConvertDAE.convert: time 0.002656/1.047, allocations: 2.028 MB / 0.8253 GB, free: 10.39 MB / 0.6387 GB
Notification: Performance of FrontEnd - DAE generated: time 5.089e-06/1.047, allocations: 4.938 kB / 0.8253 GB, free: 10.39 MB / 0.6387 GB
Notification: Performance of FrontEnd: time 1.543e-06/1.047, allocations: 0 / 0.8253 GB, free: 10.39 MB / 0.6387 GB
Notification: Performance of Transformations before backend: time 2.02e-05/1.047, allocations: 0 / 0.8253 GB, free: 10.39 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: 251
 * Number of variables: 251
Notification: Performance of Generate backend data structure: time 0.003346/1.051, allocations: 1.733 MB / 0.827 GB, free: 25.39 MB / 0.6544 GB
Notification: Performance of prepare preOptimizeDAE: time 3.942e-05/1.051, allocations: 9.344 kB / 0.827 GB, free: 25.39 MB / 0.6544 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001741/1.051, allocations: 152.2 kB / 0.8271 GB, free: 25.35 MB / 0.6544 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002639/1.054, allocations: 0.5331 MB / 0.8277 GB, free: 25.25 MB / 0.6544 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001989/1.056, allocations: 1.077 MB / 0.8287 GB, free: 24.9 MB / 0.6544 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008264/1.056, allocations: 275 kB / 0.829 GB, free: 24.88 MB / 0.6544 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001503/1.057, allocations: 101.4 kB / 0.8291 GB, free: 24.88 MB / 0.6544 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002257/1.059, allocations: 1.33 MB / 0.8304 GB, free: 24.59 MB / 0.6544 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.578e-05/1.059, allocations: 7.078 kB / 0.8304 GB, free: 24.59 MB / 0.6544 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 9.284e-05/1.059, allocations: 45.17 kB / 0.8304 GB, free: 24.59 MB / 0.6544 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.992e-05/1.059, allocations: 42.34 kB / 0.8305 GB, free: 24.58 MB / 0.6544 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002324/1.061, allocations: 1.109 MB / 0.8316 GB, free: 24.55 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.007098/1.068, allocations: 6.651 MB / 0.838 GB, free: 20.37 MB / 0.6544 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001505/1.07, allocations: 0.6015 MB / 0.8386 GB, free: 20.33 MB / 0.6544 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005862/1.071, allocations: 291 kB / 0.8389 GB, free: 20.31 MB / 0.6544 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003474/1.071, allocations: 285.4 kB / 0.8392 GB, free: 20.02 MB / 0.6544 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.023e-05/1.071, allocations: 37.25 kB / 0.8392 GB, free: 19.98 MB / 0.6544 GB
Notification: Performance of pre-optimization done (n=33): time 2.064e-06/1.071, allocations: 0 / 0.8392 GB, free: 19.98 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=33): time 0.002172/1.073, allocations: 0.9013 MB / 0.8401 GB, free: 19.85 MB / 0.6544 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.898e-05/1.073, allocations: 63.69 kB / 0.8402 GB, free: 19.79 MB / 0.6544 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001601/1.075, allocations: 1.347 MB / 0.8415 GB, free: 19.62 MB / 0.6544 GB
Notification: Performance of collectPreVariables (initialization): time 6.716e-05/1.075, allocations: 35.67 kB / 0.8415 GB, free: 19.59 MB / 0.6544 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00042/1.075, allocations: 0.6829 MB / 0.8422 GB, free: 19.33 MB / 0.6544 GB
Notification: Performance of collectInitialBindings (initialization): time 9.096e-05/1.075, allocations: 120.4 kB / 0.8423 GB, free: 19.26 MB / 0.6544 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.506e-05/1.075, allocations: 10.56 kB / 0.8423 GB, free: 19.26 MB / 0.6544 GB
Notification: Performance of setup shared object (initialization): time 0.0001172/1.076, allocations: 340 kB / 0.8426 GB, free: 18.95 MB / 0.6544 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007499/1.076, allocations: 322.1 kB / 0.8429 GB, free: 18.94 MB / 0.6544 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000874/1.077, allocations: 0.6655 MB / 0.8436 GB, free: 18.52 MB / 0.6544 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0008048/1.078, allocations: 402.3 kB / 0.844 GB, free: 18.5 MB / 0.6544 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.163e-06/1.078, allocations: 1.781 kB / 0.844 GB, free: 18.5 MB / 0.6544 GB
Notification: Performance of matching and sorting (n=81) (initialization): time 0.002026/1.08, allocations: 1.047 MB / 0.845 GB, free: 18.38 MB / 0.6544 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001764/1.08, allocations: 376 kB / 0.8453 GB, free: 17.94 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.601e-05/1.08, allocations: 8.5 kB / 0.8454 GB, free: 17.94 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.984e-05/1.08, allocations: 19.23 kB / 0.8454 GB, free: 17.93 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007653/1.081, allocations: 207 kB / 0.8456 GB, free: 17.93 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.101e-05/1.081, allocations: 21.44 kB / 0.8456 GB, free: 17.93 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001617/1.083, allocations: 232.5 kB / 0.8458 GB, free: 17.86 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.132e-05/1.083, allocations: 42.03 kB / 0.8459 GB, free: 17.86 MB / 0.6544 GB
Notification: Performance of prepare postOptimizeDAE: time 9.929e-06/1.083, allocations: 5.531 kB / 0.8459 GB, free: 17.86 MB / 0.6544 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001858/1.085, allocations: 0.8945 MB / 0.8467 GB, free: 17.83 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.281e-05/1.085, allocations: 8.625 kB / 0.8467 GB, free: 17.83 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.776e-05/1.085, allocations: 20.52 kB / 0.8468 GB, free: 17.83 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000743/1.086, allocations: 209.8 kB / 0.847 GB, free: 17.83 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.172e-05/1.086, allocations: 26.47 kB / 0.847 GB, free: 17.82 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001343/1.087, allocations: 209.7 kB / 0.8472 GB, free: 17.76 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.247e-05/1.087, allocations: 41.38 kB / 0.8472 GB, free: 17.76 MB / 0.6544 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 43
 * 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 (81):
 * Single equations (assignments): 81
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0006987/1.088, allocations: 410.8 kB / 0.8476 GB, free: 17.57 MB / 0.6544 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003354/1.088, allocations: 133.9 kB / 0.8477 GB, free: 17.5 MB / 0.6544 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00165/1.09, allocations: 0.6863 MB / 0.8484 GB, free: 17.42 MB / 0.6544 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 6.101e-06/1.09, allocations: 3.344 kB / 0.8484 GB, free: 17.42 MB / 0.6544 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.424e-06/1.09, allocations: 3.953 kB / 0.8484 GB, free: 17.41 MB / 0.6544 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.672e-06/1.09, allocations: 10.06 kB / 0.8484 GB, free: 17.41 MB / 0.6544 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003705/1.093, allocations: 1.937 MB / 0.8503 GB, free: 16.93 MB / 0.6544 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.09e-05/1.093, allocations: 3.469 kB / 0.8503 GB, free: 16.93 MB / 0.6544 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0004963/1.094, allocations: 110.6 kB / 0.8504 GB, free: 16.93 MB / 0.6544 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.095e-05/1.094, allocations: 5.844 kB / 0.8504 GB, free: 16.93 MB / 0.6544 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.573e-05/1.094, allocations: 12.17 kB / 0.8504 GB, free: 16.93 MB / 0.6544 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.286e-06/1.094, allocations: 9.375 kB / 0.8505 GB, free: 16.93 MB / 0.6544 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.529e-06/1.094, allocations: 5.094 kB / 0.8505 GB, free: 16.93 MB / 0.6544 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001526/1.096, allocations: 0.8497 MB / 0.8513 GB, free: 16.57 MB / 0.6544 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007017/1.096, allocations: 282 kB / 0.8516 GB, free: 16.4 MB / 0.6544 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003955/1.097, allocations: 13.81 kB / 0.8516 GB, free: 16.4 MB / 0.6544 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001062/1.098, allocations: 105.9 kB / 0.8517 GB, free: 16.39 MB / 0.6544 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.749e-05/1.098, allocations: 32.3 kB / 0.8517 GB, free: 16.39 MB / 0.6544 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.158e-05/1.098, allocations: 23.92 kB / 0.8517 GB, free: 16.39 MB / 0.6544 GB
Notification: Performance of sorting global known variables: time 0.001377/1.099, allocations: 0.9299 MB / 0.8526 GB, free: 16.27 MB / 0.6544 GB
Notification: Performance of sort global known variables: time 2.61e-07/1.099, allocations: 0 / 0.8526 GB, free: 16.27 MB / 0.6544 GB
Notification: Performance of remove unused functions: time 0.002182/1.102, allocations: 0.5748 MB / 0.8532 GB, free: 16.21 MB / 0.6544 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 16
 * 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 simulation (32):
 * Single equations (assignments): 32
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.002142/1.104, allocations: 1.543 MB / 0.8547 GB, free: 15.3 MB / 0.6544 GB
Notification: Performance of simCode: created initialization part: time 0.002543/1.106, allocations: 1.158 MB / 0.8558 GB, free: 15.26 MB / 0.6544 GB
Notification: Performance of simCode: created event and clocks part: time 4.99e-06/1.106, allocations: 0 / 0.8558 GB, free: 15.26 MB / 0.6544 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005998/1.107, allocations: 280.5 kB / 0.8561 GB, free: 15.25 MB / 0.6544 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003267/1.11, allocations: 0.6318 MB / 0.8567 GB, free: 15.2 MB / 0.6544 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01493/1.125, allocations: 7.821 MB / 0.8644 GB, free: 12.25 MB / 0.6544 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0007638/1.126, allocations: 1.181 MB / 0.8655 GB, free: 11.53 MB / 0.6544 GB
Notification: Performance of simCode: alias equations: time 0.001615/1.127, allocations: 347.8 kB / 0.8658 GB, free: 11.44 MB / 0.6544 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005794/1.128, allocations: 488.6 kB / 0.8663 GB, free: 11.43 MB / 0.6544 GB
Notification: Performance of SimCode: time 1.503e-06/1.128, allocations: 3.531 kB / 0.8663 GB, free: 11.43 MB / 0.6544 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.05536/1.183, allocations: 33.25 MB / 0.8988 GB, free: 13.28 MB / 0.67 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001892/1.184, allocations: 209.9 kB / 0.899 GB, free: 13.04 MB / 0.67 GB
Notification: Performance of buildModelFMU: Generate platform static: time 2.381/3.565, allocations: 0 / 0.899 GB, free: 13.04 MB / 0.67 GB
(rm -f IDEAS_IDEAS.Fluid.Examples.Performance.Example4.pipe ; mkfifo IDEAS_IDEAS.Fluid.Examples.Performance.Example4.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.Examples.Performance.Example4.pipe >> ../files/IDEAS_IDEAS.Fluid.Examples.Performance.Example4.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator  --tempDir=temp_IDEAS_IDEAS_Fluid_Examples_Performance_Example4_fmu --startTime=0 --stopTime=20 --timeout=50 --tolerance=1e-06 IDEAS_IDEAS_Fluid_Examples_Performance_Example4.fmu > IDEAS_IDEAS.Fluid.Examples.Performance.Example4.pipe 2>&1)
Environment - environmentSimulation: