Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.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-master/package.mo", uses=false)
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: "" <> buildModelFMU(IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Interfaces_Examples_ReverseFlowMassExchanger",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Interfaces_Examples_ReverseFlowMassExchanger",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.001173/0.001174, allocations: 99.39 kB / 15.05 MB, free: 1.105 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.001632/0.001632, allocations: 177.3 kB / 15.94 MB, free: 220 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 2.329/2.329, allocations: 223.2 MB / 239.9 MB, free: 5.465 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 1.701/1.701, allocations: 135.2 MB / 426.2 MB, free: 14.25 MB / 350.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0008361/0.0008365, allocations: 16 kB / 0.5069 GB, free: 5.184 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3074/0.3083, allocations: 82.31 MB / 0.5873 GB, free: 3.047 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger): time 1.049/1.357, allocations: 265.3 MB / 0.8464 GB, free: 2.855 MB / 0.6544 GB
Notification: Performance of NFInst.instExpressions: time 0.9454/2.303, allocations: 27.09 MB / 0.8728 GB, free: 9.727 MB / 0.67 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.007583/2.31, allocations: 79.69 kB / 0.8729 GB, free: 9.727 MB / 0.67 GB
Notification: Performance of NFTyping.typeComponents: time 0.009948/2.32, allocations: 1.671 MB / 0.8746 GB, free: 9.719 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.02701/2.348, allocations: 4.677 MB / 0.8791 GB, free: 9.664 MB / 0.67 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01304/2.361, allocations: 2.608 MB / 0.8817 GB, free: 9.625 MB / 0.67 GB
Notification: Performance of NFFlatten.flatten: time 0.01505/2.376, allocations: 3.919 MB / 0.8855 GB, free: 9.613 MB / 0.67 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.00899/2.385, allocations: 2.244 MB / 0.8877 GB, free: 25.34 MB / 0.6856 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.015/2.4, allocations: 3.46 MB / 0.8911 GB, free: 25.32 MB / 0.6856 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007384/2.407, allocations: 1.59 MB / 0.8926 GB, free: 25.31 MB / 0.6856 GB
Notification: Performance of NFPackage.collectConstants: time 0.002157/2.409, allocations: 129.9 kB / 0.8927 GB, free: 25.31 MB / 0.6856 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01396/2.423, allocations: 2.21 MB / 0.8949 GB, free: 25.31 MB / 0.6856 GB
Notification: Performance of NFScalarize.scalarize: time 0.004014/2.427, allocations: 0.8144 MB / 0.8957 GB, free: 25.31 MB / 0.6856 GB
Notification: Performance of NFVerifyModel.verify: time 0.004266/2.432, allocations: 0.6297 MB / 0.8963 GB, free: 25.28 MB / 0.6856 GB
Notification: Performance of NFConvertDAE.convert: time 0.01482/2.447, allocations: 3.625 MB / 0.8999 GB, free: 25 MB / 0.6856 GB
Notification: Performance of FrontEnd - DAE generated: time 5e-06/2.447, allocations: 0 / 0.8999 GB, free: 25 MB / 0.6856 GB
Notification: Performance of FrontEnd: time 4.97e-06/2.447, allocations: 0 / 0.8999 GB, free: 25 MB / 0.6856 GB
Notification: Performance of Transformations before backend: time 0.000242/2.447, allocations: 0.9375 kB / 0.8999 GB, free: 25 MB / 0.6856 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 536
 * Number of variables: 536
Notification: Performance of Generate backend data structure: time 0.01734/2.464, allocations: 3.003 MB / 0.9028 GB, free: 23.45 MB / 0.6856 GB
Notification: Performance of prepare preOptimizeDAE: time 9.081e-05/2.464, allocations: 11.72 kB / 0.9028 GB, free: 23.45 MB / 0.6856 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002373/2.467, allocations: 296.8 kB / 0.9031 GB, free: 23.4 MB / 0.6856 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.016/2.483, allocations: 1.584 MB / 0.9046 GB, free: 23.16 MB / 0.6856 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01088/2.494, allocations: 1.901 MB / 0.9065 GB, free: 22.68 MB / 0.6856 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.002917/2.497, allocations: 430.3 kB / 0.9069 GB, free: 22.64 MB / 0.6856 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002404/2.499, allocations: 224.8 kB / 0.9071 GB, free: 22.64 MB / 0.6856 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01408/2.513, allocations: 3.071 MB / 0.9101 GB, free: 22.27 MB / 0.6856 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.142e-05/2.514, allocations: 10.52 kB / 0.9101 GB, free: 22.27 MB / 0.6856 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005257/2.514, allocations: 91.75 kB / 0.9102 GB, free: 22.27 MB / 0.6856 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002083/2.514, allocations: 83.38 kB / 0.9103 GB, free: 22.26 MB / 0.6856 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01546/2.53, allocations: 3.207 MB / 0.9134 GB, free: 22.18 MB / 0.6856 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.04672/2.577, allocations: 14.29 MB / 0.9274 GB, free: 13.94 MB / 0.6856 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007423/2.584, allocations: 1.702 MB / 0.929 GB, free: 13.64 MB / 0.6856 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007626/2.585, allocations: 163.9 kB / 0.9292 GB, free: 13.52 MB / 0.6856 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.873e-05/2.585, allocations: 51.81 kB / 0.9292 GB, free: 13.48 MB / 0.6856 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002976/2.588, allocations: 195.4 kB / 0.9294 GB, free: 13.38 MB / 0.6856 GB
Notification: Performance of pre-optimization done (n=110): time 6.803e-06/2.588, allocations: 0 / 0.9294 GB, free: 13.38 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=110): time 0.01075/2.599, allocations: 2.409 MB / 0.9318 GB, free: 12.84 MB / 0.6856 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001212/2.599, allocations: 67.92 kB / 0.9318 GB, free: 12.78 MB / 0.6856 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008346/2.607, allocations: 2.533 MB / 0.9343 GB, free: 12.1 MB / 0.6856 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007072/2.608, allocations: 61.58 kB / 0.9344 GB, free: 12.07 MB / 0.6856 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001702/2.61, allocations: 1.26 MB / 0.9356 GB, free: 11.5 MB / 0.6856 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007073/2.61, allocations: 395.7 kB / 0.936 GB, free: 11.21 MB / 0.6856 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002052/2.611, allocations: 36.38 kB / 0.936 GB, free: 11.21 MB / 0.6856 GB
Notification: Performance of setup shared object (initialization): time 0.0002986/2.611, allocations: 374.2 kB / 0.9364 GB, free: 10.89 MB / 0.6856 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.004628/2.616, allocations: 0.9912 MB / 0.9373 GB, free: 10.69 MB / 0.6856 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.005016/2.621, allocations: 1.638 MB / 0.9389 GB, free: 9.719 MB / 0.6856 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.004516/2.625, allocations: 1.2 MB / 0.9401 GB, free: 9.457 MB / 0.6856 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.582e-05/2.625, allocations: 5.469 kB / 0.9401 GB, free: 9.457 MB / 0.6856 GB
Notification: Performance of matching and sorting (n=216) (initialization): time 0.01209/2.637, allocations: 2.879 MB / 0.9429 GB, free: 8.773 MB / 0.6856 GB
Notification: Performance of prepare postOptimizeDAE: time 0.003123/2.64, allocations: 5.771 MB / 0.9486 GB, free: 2.617 MB / 0.6856 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.147e-05/2.641, allocations: 15.77 kB / 0.9486 GB, free: 2.613 MB / 0.6856 GB
Notification: Performance of postOpt tearingSystem (initialization): time 7.996e-05/2.641, allocations: 25.22 kB / 0.9486 GB, free: 2.613 MB / 0.6856 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005585/2.646, allocations: 0.5916 MB / 0.9492 GB, free: 2.488 MB / 0.6856 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00214/2.648, allocations: 2.385 MB / 0.9515 GB, free: 16.12 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008327/2.657, allocations: 447 kB / 0.9519 GB, free: 15.97 MB / 0.7012 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008405/2.658, allocations: 93.2 kB / 0.952 GB, free: 15.96 MB / 0.7012 GB
Notification: Performance of prepare postOptimizeDAE: time 2.255e-05/2.658, allocations: 3.25 kB / 0.952 GB, free: 15.96 MB / 0.7012 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.01065/2.668, allocations: 2.645 MB / 0.9546 GB, free: 15.43 MB / 0.7012 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.351e-05/2.668, allocations: 15.5 kB / 0.9546 GB, free: 15.43 MB / 0.7012 GB
Notification: Performance of postOpt tearingSystem (initialization): time 4.465e-05/2.668, allocations: 29.89 kB / 0.9547 GB, free: 15.43 MB / 0.7012 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003571/2.672, allocations: 0.5323 MB / 0.9552 GB, free: 15.32 MB / 0.7012 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.377e-05/2.672, allocations: 31.77 kB / 0.9552 GB, free: 15.32 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005609/2.678, allocations: 376.5 kB / 0.9556 GB, free: 15.2 MB / 0.7012 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005375/2.678, allocations: 94.98 kB / 0.9557 GB, free: 15.18 MB / 0.7012 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 61
 * Number of states: 0 ()
 * Number of discrete variables: 4 (masExcFor.i1_w,masExcFor.i2_w,masExcRev.i1_w,masExcRev.i2_w)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (214):
 * Single equations (assignments): 208
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 4
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 4 {1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.002249/2.681, allocations: 0.6255 MB / 0.9563 GB, free: 14.96 MB / 0.7012 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001117/2.682, allocations: 259.5 kB / 0.9565 GB, free: 14.82 MB / 0.7012 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006633/2.688, allocations: 1.882 MB / 0.9584 GB, free: 14.37 MB / 0.7012 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.676e-05/2.688, allocations: 15.23 kB / 0.9584 GB, free: 14.36 MB / 0.7012 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.127e-05/2.688, allocations: 0 / 0.9584 GB, free: 14.36 MB / 0.7012 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.971e-05/2.689, allocations: 3.984 kB / 0.9584 GB, free: 14.36 MB / 0.7012 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.01403/2.703, allocations: 4.541 MB / 0.9628 GB, free: 12.79 MB / 0.7012 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.817e-05/2.703, allocations: 5.406 kB / 0.9628 GB, free: 12.79 MB / 0.7012 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002437/2.705, allocations: 321.8 kB / 0.9631 GB, free: 12.73 MB / 0.7012 GB
Notification: Performance of postOpt tearingSystem (simulation): time 2.286e-05/2.705, allocations: 9.219 kB / 0.9631 GB, free: 12.73 MB / 0.7012 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001385/2.705, allocations: 35.19 kB / 0.9632 GB, free: 12.72 MB / 0.7012 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001704/2.707, allocations: 2.362 MB / 0.9655 GB, free: 10.36 MB / 0.7012 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.17e-05/2.707, allocations: 15.8 kB / 0.9655 GB, free: 10.35 MB / 0.7012 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.007021/2.714, allocations: 2.5 MB / 0.9679 GB, free: 8.949 MB / 0.7012 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003385/2.717, allocations: 0.534 MB / 0.9684 GB, free: 8.637 MB / 0.7012 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001328/2.719, allocations: 32.11 kB / 0.9685 GB, free: 8.629 MB / 0.7012 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004662/2.723, allocations: 290.4 kB / 0.9688 GB, free: 8.527 MB / 0.7012 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002297/2.724, allocations: 81.83 kB / 0.9688 GB, free: 8.492 MB / 0.7012 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002663/2.724, allocations: 62.8 kB / 0.9689 GB, free: 8.48 MB / 0.7012 GB
Notification: Performance of sorting global known variables: time 0.005624/2.73, allocations: 1.748 MB / 0.9706 GB, free: 8.035 MB / 0.7012 GB
Notification: Performance of sort global known variables: time 4.21e-07/2.73, allocations: 0 / 0.9706 GB, free: 8.035 MB / 0.7012 GB
Notification: Performance of remove unused functions: time 0.009029/2.739, allocations: 1.295 MB / 0.9719 GB, free: 7.703 MB / 0.7012 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 25
 * 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 (110):
 * Single equations (assignments): 106
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 4
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 4 {1,1,1,1}
 * Without analytic Jacobian: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.009381/2.748, allocations: 4.751 MB / 0.9765 GB, free: 3.324 MB / 0.7012 GB
Notification: Performance of simCode: created initialization part: time 0.01257/2.761, allocations: 3.708 MB / 0.9801 GB, free: 0.5 MB / 0.7012 GB
Notification: Performance of simCode: created event and clocks part: time 2.236e-05/2.761, allocations: 5.75 kB / 0.9801 GB, free: 0.4961 MB / 0.7012 GB
Notification: Performance of simCode: created simulation system equations: time 0.003077/2.764, allocations: 0.8246 MB / 0.9809 GB, free: 15.9 MB / 0.7169 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.0102/2.774, allocations: 1.191 MB / 0.9821 GB, free: 14.92 MB / 0.7169 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02434/2.799, allocations: 16.33 MB / 0.998 GB, free: 14.63 MB / 0.7325 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002253/2.801, allocations: 1.751 MB / 0.9998 GB, free: 12.9 MB / 0.7325 GB
Notification: Performance of simCode: alias equations: time 0.007365/2.808, allocations: 0.7857 MB / 1.001 GB, free: 12.11 MB / 0.7325 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002354/2.811, allocations: 1.01 MB / 1.002 GB, free: 11.85 MB / 0.7325 GB
Notification: Performance of SimCode: time 1.433e-06/2.811, allocations: 0 / 1.002 GB, free: 11.85 MB / 0.7325 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.2005/3.011, allocations: 65.58 MB / 1.066 GB, free: 11.18 MB / 0.795 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0003159/3.012, allocations: 257.9 kB / 1.066 GB, free: 10.84 MB / 0.795 GB
Notification: Performance of buildModelFMU: Generate platform static: time 5.261/8.273, allocations: 0 / 1.066 GB, free: 10.84 MB / 0.795 GB
(rm -f IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator  --tempDir=temp_IDEAS_dev_IDEAS_Fluid_Interfaces_Examples_ReverseFlowMassExchanger_fmu --startTime=0 --stopTime=1 --timeout=50 --tolerance=1e-06 IDEAS_dev_IDEAS_Fluid_Interfaces_Examples_ReverseFlowMassExchanger.fmu > IDEAS_dev_IDEAS.Fluid.Interfaces.Examples.ReverseFlowMassExchanger.pipe 2>&1)
Environment - environmentSimulation: