Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ThermoSysPro_ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo", uses=false)
Using package ThermoSysPro with version 4.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo)
Running command: "" <> buildModelFMU(ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger,fileNamePrefix="ThermoSysPro_ThermoSysPro_Fluid_Examples_SimpleExamples_TestDynamicWaterSteamMultiFluidHeatExchanger",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger,fileNamePrefix="ThermoSysPro_ThermoSysPro_Fluid_Examples_SimpleExamples_TestDynamicWaterSteamMultiFluidHeatExchanger",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ThermoSysPro 4.0.0-master/package.mo): time 0.8219/0.8219, allocations: 150.8 MB / 166.1 MB, free: 15.41 MB / 142.1 MB
Notification: Performance of FrontEnd - loaded program: time 1.515e-05/1.517e-05, allocations: 4 kB / 204.9 MB, free: 9.969 MB / 174.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1526/0.1527, allocations: 31.99 MB / 236.8 MB, free: 5.406 MB / 190.1 MB
Notification: Automatically loaded package Complex 4.0.0 due to uses annotation.
Notification: Automatically loaded package ModelicaServices 4.0.0 due to uses annotation.
Notification: Automatically loaded package Modelica 4.0.0 due to usage.
Notification: Performance of NFInst.instantiate(ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger): time 1.553/1.706, allocations: 299.1 MB / 0.5233 GB, free: 8.801 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.4746/2.18, allocations: 199.9 MB / 0.7186 GB, free: 3.883 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000872/2.181, allocations: 28.81 kB / 0.7186 GB, free: 3.879 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.0006666/2.182, allocations: 327.5 kB / 0.7189 GB, free: 3.879 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.001563/2.183, allocations: 0.9973 MB / 0.7199 GB, free: 3.879 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02743/2.211, allocations: 12.13 MB / 0.7318 GB, free: 3.531 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.00596/2.217, allocations: 8.633 MB / 0.7402 GB, free: 3.504 MB / 0.5762 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002485/2.219, allocations: 2.199 MB / 0.7423 GB, free: 3.297 MB / 0.5762 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002324/2.222, allocations: 2.084 MB / 0.7444 GB, free: 3.297 MB / 0.5762 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003215/2.225, allocations: 2.85 MB / 0.7472 GB, free: 3.293 MB / 0.5762 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004637/2.225, allocations: 225.8 kB / 0.7474 GB, free: 3.293 MB / 0.5762 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03672/2.262, allocations: 24.54 MB / 0.7713 GB, free: 12.85 MB / 0.5919 GB
Notification: Performance of NFScalarize.scalarize: time 0.001768/2.264, allocations: 1.499 MB / 0.7728 GB, free: 12.36 MB / 0.5919 GB
Notification: Performance of NFVerifyModel.verify: time 0.002829/2.267, allocations: 2.085 MB / 0.7748 GB, free: 12.09 MB / 0.5919 GB
Notification: Performance of NFConvertDAE.convert: time 0.03134/2.298, allocations: 18.16 MB / 0.7926 GB, free: 13.14 MB / 0.6075 GB
Notification: Performance of FrontEnd - DAE generated: time 5.2e-06/2.298, allocations: 3.938 kB / 0.7926 GB, free: 13.13 MB / 0.6075 GB
Notification: Performance of FrontEnd: time 1.603e-06/2.298, allocations: 0 / 0.7926 GB, free: 13.13 MB / 0.6075 GB
Notification: Performance of Transformations before backend: time 5.625e-05/2.298, allocations: 0 / 0.7926 GB, free: 13.13 MB / 0.6075 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1023
 * Number of variables: 1023
Notification: Performance of Generate backend data structure: time 0.01871/2.317, allocations: 6.089 MB / 0.7985 GB, free: 6.988 MB / 0.6075 GB
Notification: Performance of prepare preOptimizeDAE: time 3.842e-05/2.317, allocations: 8.031 kB / 0.7985 GB, free: 6.98 MB / 0.6075 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0007672/2.318, allocations: 0.5353 MB / 0.799 GB, free: 6.438 MB / 0.6075 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006968/2.318, allocations: 407.5 kB / 0.7994 GB, free: 6.035 MB / 0.6075 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002849/2.321, allocations: 1.945 MB / 0.8013 GB, free: 4.16 MB / 0.6075 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001283/2.322, allocations: 1.211 MB / 0.8025 GB, free: 2.781 MB / 0.6075 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006138/2.323, allocations: 304 kB / 0.8028 GB, free: 2.484 MB / 0.6075 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01353/2.337, allocations: 7.468 MB / 0.8101 GB, free: 10.95 MB / 0.6231 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.266e-05/2.337, allocations: 0 / 0.8101 GB, free: 10.95 MB / 0.6231 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004424/2.337, allocations: 128 kB / 0.8102 GB, free: 10.82 MB / 0.6231 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.799e-05/2.337, allocations: 112 kB / 0.8103 GB, free: 10.71 MB / 0.6231 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02126/2.359, allocations: 11.5 MB / 0.8216 GB, free: 15.21 MB / 0.6387 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.195/2.554, allocations: 119.8 MB / 0.9385 GB, free: 10.77 MB / 0.7637 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0196/2.573, allocations: 8.317 MB / 0.9466 GB, free: 2.375 MB / 0.7637 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.009795/2.583, allocations: 5.205 MB / 0.9517 GB, free: 13.16 MB / 0.7794 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.8526/3.436, allocations: 417.8 MB / 1.36 GB, free: 34.68 MB / 0.795 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.919e-05/3.436, allocations: 77.56 kB / 1.36 GB, free: 34.62 MB / 0.795 GB
Notification: Performance of pre-optimization done (n=654): time 5.921e-06/3.436, allocations: 0 / 1.36 GB, free: 34.62 MB / 0.795 GB
Notification: Performance of matching and sorting (n=654): time 0.03739/3.473, allocations: 19.19 MB / 1.379 GB, free: 16 MB / 0.795 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.378e-05/3.473, allocations: 98.84 kB / 1.379 GB, free: 15.89 MB / 0.795 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001121/3.474, allocations: 1.013 MB / 1.38 GB, free: 14.88 MB / 0.795 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003716/3.475, allocations: 89.7 kB / 1.38 GB, free: 14.78 MB / 0.795 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003465/3.475, allocations: 0.7881 MB / 1.38 GB, free: 14 MB / 0.795 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001252/3.476, allocations: 2.155 MB / 1.383 GB, free: 11.86 MB / 0.795 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005847/3.477, allocations: 424.4 kB / 1.383 GB, free: 11.45 MB / 0.795 GB
Notification: Performance of setup shared object (initialization): time 3.617e-05/3.477, allocations: 309.1 kB / 1.383 GB, free: 11.14 MB / 0.795 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008254/3.485, allocations: 4.46 MB / 1.388 GB, free: 6.676 MB / 0.795 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.008693/3.494, allocations: 5.128 MB / 1.393 GB, free: 1.375 MB / 0.795 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.1953/3.689, allocations: 9.737 MB / 1.402 GB, free: 429.1 MB / 0.795 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.867e-05/3.689, allocations: 2.906 kB / 1.402 GB, free: 429.1 MB / 0.795 GB
Notification: Performance of matching and sorting (n=718) (initialization): time 0.03048/3.72, allocations: 15.27 MB / 1.417 GB, free: 428.8 MB / 0.795 GB
Notification: Performance of prepare postOptimizeDAE: time 3.019e-05/3.72, allocations: 11.06 kB / 1.417 GB, free: 428.8 MB / 0.795 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.818e-05/3.72, allocations: 29.33 kB / 1.417 GB, free: 428.8 MB / 0.795 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.07628/3.796, allocations: 22.27 MB / 1.439 GB, free: 424.9 MB / 0.795 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009114/3.797, allocations: 227.6 kB / 1.439 GB, free: 424.7 MB / 0.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03268/3.83, allocations: 17.83 MB / 1.456 GB, free: 407.2 MB / 0.795 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004957/3.835, allocations: 0.9599 MB / 1.457 GB, free: 406.3 MB / 0.795 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004566/3.835, allocations: 211.8 kB / 1.458 GB, free: 406 MB / 0.795 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 57
 * Number of states: 0 ()
 * Number of discrete variables: 12 (sourceP1.C.ftype,sourceP.C.ftype,sinkP.fluid,dynamicMultiFluidHeatExchanger.ExchangerMultiFluids.fluid,dynamicMultiFluidHeatExchanger.TwoPhaseFlowPipe.fluid,sinkP1.fluid,sourceP1.fluid1,sourceP.fluid1,dynamicMultiFluidHeatExchanger.TwoPhaseFlowPipe.C1.diff_on_2,dynamicMultiFluidHeatExchanger.TwoPhaseFlowPipe.C2.diff_on_1,dynamicMultiFluidHeatExchanger.ExchangerMultiFluids.C1.diff_on_2,dynamicMultiFluidHeatExchanger.ExchangerMultiFluids.C2.diff_on_1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (109):
 * Single equations (assignments): 106
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 2
 * 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
   {(22,372)}
Notification: Performance of prepare postOptimizeDAE: time 0.001704/3.837, allocations: 1.016 MB / 1.459 GB, free: 405 MB / 0.795 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005399/3.838, allocations: 284.4 kB / 1.459 GB, free: 404.7 MB / 0.795 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03057/3.868, allocations: 17.31 MB / 1.476 GB, free: 387.4 MB / 0.795 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.02675/3.895, allocations: 14.99 MB / 1.49 GB, free: 372.3 MB / 0.795 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.034e-05/3.895, allocations: 0 / 1.49 GB, free: 372.3 MB / 0.795 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.303e-05/3.895, allocations: 31.83 kB / 1.49 GB, free: 372.3 MB / 0.795 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04732/3.942, allocations: 28.62 MB / 1.518 GB, free: 343.5 MB / 0.795 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.717e-05/3.942, allocations: 8 kB / 1.518 GB, free: 343.5 MB / 0.795 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008203/3.943, allocations: 291.9 kB / 1.519 GB, free: 343.2 MB / 0.795 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.07193/4.015, allocations: 20.52 MB / 1.539 GB, free: 322.7 MB / 0.795 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.001314/4.016, allocations: 181.3 kB / 1.539 GB, free: 322.6 MB / 0.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.03014/4.047, allocations: 16.83 MB / 1.555 GB, free: 305.6 MB / 0.795 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.099e-06/4.047, allocations: 8 kB / 1.555 GB, free: 305.6 MB / 0.795 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.03757/4.084, allocations: 16.75 MB / 1.572 GB, free: 288.7 MB / 0.795 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002233/4.087, allocations: 1.319 MB / 1.573 GB, free: 287.3 MB / 0.795 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006702/4.087, allocations: 91.98 kB / 1.573 GB, free: 287.2 MB / 0.795 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004522/4.092, allocations: 0.6788 MB / 1.574 GB, free: 286.6 MB / 0.795 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0006856/4.092, allocations: 339.6 kB / 1.574 GB, free: 286.2 MB / 0.795 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003939/4.093, allocations: 195.8 kB / 1.574 GB, free: 286 MB / 0.795 GB
Notification: Performance of sorting global known variables: time 0.0007862/4.094, allocations: 0.7391 MB / 1.575 GB, free: 285.3 MB / 0.795 GB
Notification: Performance of sort global known variables: time 1.3e-07/4.094, allocations: 0 / 1.575 GB, free: 285.3 MB / 0.795 GB
Notification: Performance of remove unused functions: time 0.006418/4.1, allocations: 3.15 MB / 1.578 GB, free: 282.4 MB / 0.795 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 11
 * 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 (159):
 * Single equations (assignments): 157
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 1
 * 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
   {(22,371)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.04509/4.145, allocations: 20.52 MB / 1.598 GB, free: 262.3 MB / 0.795 GB
Notification: Performance of simCode: created initialization part: time 0.02259/4.168, allocations: 11.82 MB / 1.61 GB, free: 250.3 MB / 0.795 GB
Notification: Performance of simCode: created event and clocks part: time 5.199e-06/4.168, allocations: 0 / 1.61 GB, free: 250.3 MB / 0.795 GB
Notification: Performance of simCode: created simulation system equations: time 0.01124/4.179, allocations: 6.236 MB / 1.616 GB, free: 243.9 MB / 0.795 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005049/4.184, allocations: 1.11 MB / 1.617 GB, free: 242.9 MB / 0.795 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3026/4.487, allocations: 64.08 MB / 1.679 GB, free: 412.7 MB / 0.795 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001841/4.489, allocations: 2.598 MB / 1.682 GB, free: 411.7 MB / 0.795 GB
Notification: Performance of simCode: alias equations: time 0.001583/4.49, allocations: 0.5515 MB / 1.682 GB, free: 411.6 MB / 0.795 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001059/4.491, allocations: 1.289 MB / 1.684 GB, free: 410.6 MB / 0.795 GB
Notification: Performance of SimCode: time 6.51e-07/4.491, allocations: 0 / 1.684 GB, free: 410.6 MB / 0.795 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.4115/4.903, allocations: 227.4 MB / 1.906 GB, free: 407.2 MB / 0.795 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0001557/4.903, allocations: 326.4 kB / 1.906 GB, free: 406.8 MB / 0.795 GB
Notification: Performance of buildModelFMU: Generate platform static: time 8.761/13.66, allocations: 4 kB / 1.906 GB, free: 406.8 MB / 0.795 GB
(rm -f ThermoSysPro_ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger.pipe ; mkfifo ThermoSysPro_ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger.pipe ; head -c 1048576 < ThermoSysPro_ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger.pipe >> ../files/ThermoSysPro_ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator  --tempDir=temp_ThermoSysPro_ThermoSysPro_Fluid_Examples_SimpleExamples_TestDynamicWaterSteamMultiFluidHeatExchanger_fmu --startTime=0 --stopTime=1000 --timeout=50 --tolerance=1e-06 ThermoSysPro_ThermoSysPro_Fluid_Examples_SimpleExamples_TestDynamicWaterSteamMultiFluidHeatExchanger.fmu > ThermoSysPro_ThermoSysPro.Fluid.Examples.SimpleExamples.TestDynamicWaterSteamMultiFluidHeatExchanger.pipe 2>&1)