Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false)
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Running command: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Pipes_IdealMixing1",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Pipes_IdealMixing1",fmuType="me",version="2.0",platforms={"static"})
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001575/0.001575, allocations: 198.9 kB / 17.08 MB, free: 5.078 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.449/1.449, allocations: 227.2 MB / 245 MB, free: 5.922 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.0009944/0.0009947, allocations: 91.75 kB / 297.2 MB, free: 5.973 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.4233/0.4233, allocations: 45.23 MB / 394.6 MB, free: 31.72 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003136/0.0003138, allocations: 11.98 kB / 468.5 MB, free: 7.598 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4046/0.4049, allocations: 63.25 MB / 0.5193 GB, free: 37.73 MB / 378.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 1.917/2.322, allocations: 0.7599 GB / 1.279 GB, free: 48.87 MB / 0.5417 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002855/2.322, allocations: 91.92 kB / 1.279 GB, free: 48.79 MB / 0.5417 GB
Notification: Performance of FrontEnd - DAE generated: time 5.287/7.61, allocations: 1.151 GB / 2.43 GB, free: 57.19 MB / 0.5573 GB
Notification: Performance of FrontEnd: time 2.746e-06/7.61, allocations: 0 / 2.43 GB, free: 57.19 MB / 0.5573 GB
Notification: Performance of Transformations before backend: time 0.000168/7.61, allocations: 43.11 kB / 2.43 GB, free: 57.19 MB / 0.5573 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 334
 * Number of variables: 334
Notification: Performance of Generate backend data structure: time 0.02076/7.631, allocations: 2.629 MB / 2.433 GB, free: 56.37 MB / 0.5573 GB
Notification: Performance of prepare preOptimizeDAE: time 7.56e-05/7.631, allocations: 9.312 kB / 2.433 GB, free: 56.37 MB / 0.5573 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001588/7.632, allocations: 203.4 kB / 2.433 GB, free: 56.33 MB / 0.5573 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005371/7.638, allocations: 479.1 kB / 2.433 GB, free: 56.24 MB / 0.5573 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005301/7.643, allocations: 1.211 MB / 2.435 GB, free: 55.98 MB / 0.5573 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001425/7.643, allocations: 90.89 kB / 2.435 GB, free: 55.97 MB / 0.5573 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004949/7.644, allocations: 110.4 kB / 2.435 GB, free: 55.97 MB / 0.5573 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006307/7.65, allocations: 2.946 MB / 2.438 GB, free: 55.77 MB / 0.5573 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.08e-05/7.65, allocations: 3.938 kB / 2.438 GB, free: 55.77 MB / 0.5573 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002898/7.651, allocations: 58.19 kB / 2.438 GB, free: 55.77 MB / 0.5573 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002046/7.651, allocations: 141 kB / 2.438 GB, free: 55.76 MB / 0.5573 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006212/7.657, allocations: 3.686 MB / 2.441 GB, free: 55.75 MB / 0.5573 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.01845/7.676, allocations: 8.469 MB / 2.45 GB, free: 53.32 MB / 0.5573 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003637/7.679, allocations: 1.582 MB / 2.451 GB, free: 53.27 MB / 0.5573 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001246/7.68, allocations: 0.7521 MB / 2.452 GB, free: 52.61 MB / 0.5573 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.002e-05/7.681, allocations: 44.36 kB / 2.452 GB, free: 52.57 MB / 0.5573 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004022/7.685, allocations: 0.8431 MB / 2.453 GB, free: 52.53 MB / 0.5573 GB
Notification: Performance of pre-optimization done (n=74): time 1.472e-05/7.685, allocations: 0 / 2.453 GB, free: 52.53 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=74): time 0.01593/7.701, allocations: 4.207 MB / 2.457 GB, free: 52.3 MB / 0.5573 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001101/7.701, allocations: 136.4 kB / 2.457 GB, free: 52.14 MB / 0.5573 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003656/7.704, allocations: 1.505 MB / 2.459 GB, free: 51.99 MB / 0.5573 GB
Notification: Performance of collectPreVariables (initialization): time 0.0003798/7.705, allocations: 45.92 kB / 2.459 GB, free: 51.96 MB / 0.5573 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0008153/7.706, allocations: 0.638 MB / 2.459 GB, free: 51.78 MB / 0.5573 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0004764/7.706, allocations: 266.1 kB / 2.46 GB, free: 51.65 MB / 0.5573 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001896/7.706, allocations: 20.41 kB / 2.46 GB, free: 51.65 MB / 0.5573 GB
Notification: Performance of setup shared object (initialization): time 0.0001453/7.707, allocations: 344.1 kB / 2.46 GB, free: 51.34 MB / 0.5573 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001591/7.708, allocations: 0.856 MB / 2.461 GB, free: 51.34 MB / 0.5573 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001716/7.71, allocations: 1.042 MB / 2.462 GB, free: 51.15 MB / 0.5573 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001769/7.712, allocations: 0.965 MB / 2.463 GB, free: 51.14 MB / 0.5573 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.452e-05/7.712, allocations: 3.094 kB / 2.463 GB, free: 51.14 MB / 0.5573 GB
Notification: Performance of matching and sorting (n=121) (initialization): time 0.006023/7.718, allocations: 2.716 MB / 2.465 GB, free: 50.99 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0006866/7.718, allocations: 1.871 MB / 2.467 GB, free: 49.09 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.413e-05/7.718, allocations: 3.562 kB / 2.467 GB, free: 49.09 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02155/7.74, allocations: 3.729 MB / 2.471 GB, free: 49.07 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001555/7.742, allocations: 187.3 kB / 2.471 GB, free: 49.07 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004834/7.747, allocations: 2.251 MB / 2.473 GB, free: 48.53 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002665/7.749, allocations: 89.33 kB / 2.473 GB, free: 48.53 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005526/7.75, allocations: 85.94 kB / 2.473 GB, free: 48.53 MB / 0.5573 GB
Notification: Performance of prepare postOptimizeDAE: time 2.034e-05/7.75, allocations: 4.875 kB / 2.473 GB, free: 48.53 MB / 0.5573 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005075/7.755, allocations: 2.111 MB / 2.475 GB, free: 48.49 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.862e-05/7.755, allocations: 3.688 kB / 2.475 GB, free: 48.49 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0008586/7.756, allocations: 161.4 kB / 2.476 GB, free: 48.48 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001517/7.757, allocations: 264.2 kB / 2.476 GB, free: 48.48 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003469/7.761, allocations: 2.237 MB / 2.478 GB, free: 47.2 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002396/7.763, allocations: 79.91 kB / 2.478 GB, free: 47.2 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003502/7.764, allocations: 85.36 kB / 2.478 GB, free: 47.2 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * 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 (85):
 * Single equations (assignments): 84
 * 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: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {3 34}
Notification: Performance of prepare postOptimizeDAE: time 0.001825/7.766, allocations: 0.4994 MB / 2.479 GB, free: 47.01 MB / 0.5573 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00077/7.766, allocations: 154.5 kB / 2.479 GB, free: 46.93 MB / 0.5573 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007304/7.774, allocations: 3.311 MB / 2.482 GB, free: 46.82 MB / 0.5573 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.294e-05/7.774, allocations: 16.53 kB / 2.482 GB, free: 46.81 MB / 0.5573 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.843e-06/7.774, allocations: 0 / 2.482 GB, free: 46.81 MB / 0.5573 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.585e-05/7.774, allocations: 3.797 kB / 2.482 GB, free: 46.81 MB / 0.5573 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.007894/7.782, allocations: 3.28 MB / 2.485 GB, free: 46.43 MB / 0.5573 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.987e-06/7.782, allocations: 0 / 2.485 GB, free: 46.43 MB / 0.5573 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0005226/7.782, allocations: 78.25 kB / 2.485 GB, free: 46.43 MB / 0.5573 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.01176/7.794, allocations: 2.568 MB / 2.488 GB, free: 46.42 MB / 0.5573 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0003367/7.794, allocations: 18.34 kB / 2.488 GB, free: 46.42 MB / 0.5573 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00319/7.798, allocations: 1.906 MB / 2.49 GB, free: 45.88 MB / 0.5573 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.522e-06/7.798, allocations: 3 kB / 2.49 GB, free: 45.88 MB / 0.5573 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004916/7.803, allocations: 1.927 MB / 2.492 GB, free: 45.61 MB / 0.5573 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001595/7.804, allocations: 268.3 kB / 2.492 GB, free: 45.44 MB / 0.5573 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001028/7.805, allocations: 18.09 kB / 2.492 GB, free: 45.44 MB / 0.5573 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002461/7.808, allocations: 83.53 kB / 2.492 GB, free: 45.43 MB / 0.5573 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002823/7.808, allocations: 47.83 kB / 2.492 GB, free: 45.43 MB / 0.5573 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0003386/7.809, allocations: 60.81 kB / 2.492 GB, free: 45.43 MB / 0.5573 GB
Notification: Performance of sorting global known variables: time 0.003573/7.812, allocations: 1.186 MB / 2.493 GB, free: 45.32 MB / 0.5573 GB
Notification: Performance of sort global known variables: time 5.91e-07/7.812, allocations: 0 / 2.493 GB, free: 45.32 MB / 0.5573 GB
Notification: Performance of remove unused functions: time 0.01134/7.823, allocations: 1.756 MB / 2.495 GB, free: 45.05 MB / 0.5573 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 2
 * 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 (37):
 * Single equations (assignments): 36
 * 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: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {5 35}
Notification: Performance of Backend phase and start with SimCode phase: time 0.0172/7.841, allocations: 4.733 MB / 2.5 GB, free: 43.79 MB / 0.5573 GB
Notification: Performance of simCode: created initialization part: time 0.008416/7.849, allocations: 3.015 MB / 2.502 GB, free: 43.64 MB / 0.5573 GB
Notification: Performance of simCode: created event and clocks part: time 1.942e-05/7.849, allocations: 7.688 kB / 2.502 GB, free: 43.64 MB / 0.5573 GB
Notification: Performance of simCode: created simulation system equations: time 0.001779/7.851, allocations: 0.7334 MB / 2.503 GB, free: 43.62 MB / 0.5573 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.006438/7.858, allocations: 0.9372 MB / 2.504 GB, free: 43.61 MB / 0.5573 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01695/7.875, allocations: 7.77 MB / 2.512 GB, free: 38.1 MB / 0.5573 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00163/7.876, allocations: 1.322 MB / 2.513 GB, free: 37.39 MB / 0.5573 GB
Notification: Performance of simCode: alias equations: time 0.004246/7.881, allocations: 0.9116 MB / 2.514 GB, free: 37.36 MB / 0.5573 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001285/7.882, allocations: 0.5277 MB / 2.514 GB, free: 37.35 MB / 0.5573 GB
Notification: Performance of SimCode: time 1.613e-06/7.882, allocations: 0 / 2.514 GB, free: 37.35 MB / 0.5573 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.7108/8.593, allocations: 90.97 MB / 2.603 GB, free: 73.71 MB / 0.573 GB
Notification: Performance of buildModelFMU: configured platform static using cached values: time 0.0002182/8.593, allocations: 267.6 kB / 2.604 GB, free: 73.37 MB / 0.573 GB
Notification: Performance of buildModelFMU: Generate platform static: time 5.582/14.18, allocations: 0 / 2.604 GB, free: 73.37 MB / 0.573 GB
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.sim & /home/hudson/saved_omc/OMSimulator/install/linux/bin/OMSimulator -r=ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1_res.mat --tempDir=temp_ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Pipes_IdealMixing1_fmu --startTime=0 --stopTime=10 --timeout=50 --tolerance=1e-06 ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_Pipes_IdealMixing1.fmu > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.pipe 2>&1)
TODO: How the !@#!# did the simulation report success but simulation result ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1_res.mat does not exist to compare? outputFormat=mat