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/ModelicaServices trunk/package.mo", uses=false)
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/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 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)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipeFriction1.port_b.m_flow|pipeFriction1.port_b.p|pipeFriction1.port_b.h_outflow|pipeFriction2.port_b.m_flow|pipeFriction2.port_b.p|pipeFriction2.port_b.h_outflow|pipeFriction3.port_b.m_flow|pipeFriction3.port_b.p|pipeFriction3.port_b.h_outflow|boundary1.ports.1..m_flow|boundary1.ports.1..p|boundary1.ports.1..h_outflow|boundary1.ports.1..Xi_outflow.1.|boundary1.ports.1..Xi_outflow.2.|boundary1.ports.1..Xi_outflow.3.|boundary1.ports.1..Xi_outflow.4.|boundary1.ports.1..Xi_outflow.5.|boundary1.ports.1..Xi_outflow.6.|boundary2.ports.1..m_flow|boundary2.ports.1..p|boundary2.ports.1..h_outflow|boundary2.ports.1..Xi_outflow.1.|boundary2.ports.1..Xi_outflow.2.|boundary2.ports.1..Xi_outflow.3.|boundary2.ports.1..Xi_outflow.4.|boundary2.ports.1..Xi_outflow.5.|boundary2.ports.1..Xi_outflow.6.|boundary3.ports.1..m_flow|boundary3.ports.1..p|boundary3.ports.1..h_outflow|boundary3.ports.1..Xi_outflow.1.|boundary3.ports.1..Xi_outflow.2.|boundary3.ports.1..Xi_outflow.3.|boundary3.ports.1..Xi_outflow.4.|boundary3.ports.1..Xi_outflow.5.|boundary3.ports.1..Xi_outflow.6.|sine1.y|sine2.y|sine3.y",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1")
translateModel(ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pipeFriction1.port_b.m_flow|pipeFriction1.port_b.p|pipeFriction1.port_b.h_outflow|pipeFriction2.port_b.m_flow|pipeFriction2.port_b.p|pipeFriction2.port_b.h_outflow|pipeFriction3.port_b.m_flow|pipeFriction3.port_b.p|pipeFriction3.port_b.h_outflow|boundary1.ports.1..m_flow|boundary1.ports.1..p|boundary1.ports.1..h_outflow|boundary1.ports.1..Xi_outflow.1.|boundary1.ports.1..Xi_outflow.2.|boundary1.ports.1..Xi_outflow.3.|boundary1.ports.1..Xi_outflow.4.|boundary1.ports.1..Xi_outflow.5.|boundary1.ports.1..Xi_outflow.6.|boundary2.ports.1..m_flow|boundary2.ports.1..p|boundary2.ports.1..h_outflow|boundary2.ports.1..Xi_outflow.1.|boundary2.ports.1..Xi_outflow.2.|boundary2.ports.1..Xi_outflow.3.|boundary2.ports.1..Xi_outflow.4.|boundary2.ports.1..Xi_outflow.5.|boundary2.ports.1..Xi_outflow.6.|boundary3.ports.1..m_flow|boundary3.ports.1..p|boundary3.ports.1..h_outflow|boundary3.ports.1..Xi_outflow.1.|boundary3.ports.1..Xi_outflow.2.|boundary3.ports.1..Xi_outflow.3.|boundary3.ports.1..Xi_outflow.4.|boundary3.ports.1..Xi_outflow.5.|boundary3.ports.1..Xi_outflow.6.|sine1.y|sine2.y|sine3.y",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001743/0.001743, allocations: 112.2 kB / 18.46 MB, free: 4.598 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.002213/0.002213, allocations: 206.7 kB / 19.41 MB, free: 3.652 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.507/1.507, allocations: 227.4 MB / 247.6 MB, free: 10.48 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2251/0.2251, allocations: 46.11 MB / 345 MB, free: 11.48 MB / 286.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.0017/0.0017, allocations: 71.88 kB / 482 MB, free: 4.059 MB / 350.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4048/0.4065, allocations: 62.44 MB / 0.5317 GB, free: 13.6 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1): time 0.6188/1.025, allocations: 200.7 MB / 0.7276 GB, free: 1.832 MB / 0.5606 GB
Notification: Performance of NFInst.instExpressions: time 0.02063/1.046, allocations: 14.62 MB / 0.7419 GB, free: 1.766 MB / 0.5606 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001808/1.048, allocations: 38.55 kB / 0.7419 GB, free: 1.766 MB / 0.5606 GB
Notification: Performance of NFTyping.typeComponents: time 0.00181/1.05, allocations: 0.5596 MB / 0.7425 GB, free: 1.754 MB / 0.5606 GB
Notification: Performance of NFTyping.typeBindings: time 0.009603/1.059, allocations: 3.359 MB / 0.7458 GB, free: 1.625 MB / 0.5606 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01173/1.071, allocations: 3.817 MB / 0.7495 GB, free: 1.52 MB / 0.5606 GB
Notification: Performance of NFFlatten.flatten: time 0.004741/1.076, allocations: 3.289 MB / 0.7527 GB, free: 1.512 MB / 0.5606 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002542/1.078, allocations: 1.665 MB / 0.7543 GB, free: 1.348 MB / 0.5606 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004287/1.083, allocations: 1.941 MB / 0.7562 GB, free: 1.332 MB / 0.5606 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.006333/1.089, allocations: 3.658 MB / 0.7598 GB, free: 1.316 MB / 0.5606 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005721/1.09, allocations: 186.3 kB / 0.76 GB, free: 1.316 MB / 0.5606 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01148/1.101, allocations: 5.082 MB / 0.7649 GB, free: 1.281 MB / 0.5606 GB
Notification: Performance of NFScalarize.scalarize: time 0.00187/1.103, allocations: 0.9394 MB / 0.7658 GB, free: 1.277 MB / 0.5606 GB
Notification: Performance of NFVerifyModel.verify: time 0.002184/1.105, allocations: 1.09 MB / 0.7669 GB, free: 1.277 MB / 0.5606 GB
Notification: Performance of NFConvertDAE.convert: time 0.01705/1.122, allocations: 5.894 MB / 0.7727 GB, free: 0.8281 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 6.583e-06/1.122, allocations: 3.906 kB / 0.7727 GB, free: 0.8281 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 3.216e-06/1.122, allocations: 0 / 0.7727 GB, free: 0.8281 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 8.701e-05/1.123, allocations: 0.8125 kB / 0.7727 GB, free: 0.8281 MB / 0.5606 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.01545/1.138, allocations: 2.85 MB / 0.7755 GB, free: 15.62 MB / 0.5762 GB
Notification: Performance of prepare preOptimizeDAE: time 8.969e-05/1.138, allocations: 10.75 kB / 0.7755 GB, free: 15.62 MB / 0.5762 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005656/1.144, allocations: 496.5 kB / 0.7759 GB, free: 15.54 MB / 0.5762 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.003965/1.148, allocations: 1.166 MB / 0.7771 GB, free: 14.97 MB / 0.5762 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001087/1.148, allocations: 95.02 kB / 0.7772 GB, free: 14.97 MB / 0.5762 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00044/1.148, allocations: 109.8 kB / 0.7773 GB, free: 14.97 MB / 0.5762 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005213/1.154, allocations: 2.856 MB / 0.7801 GB, free: 14.14 MB / 0.5762 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.556e-05/1.154, allocations: 0 / 0.7801 GB, free: 14.14 MB / 0.5762 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002538/1.154, allocations: 53.67 kB / 0.7801 GB, free: 14.14 MB / 0.5762 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001907/1.154, allocations: 149.2 kB / 0.7803 GB, free: 14.11 MB / 0.5762 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005698/1.16, allocations: 3.534 MB / 0.7837 GB, free: 13.46 MB / 0.5762 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.01707/1.177, allocations: 8.495 MB / 0.792 GB, free: 9.348 MB / 0.5762 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003479/1.18, allocations: 1.57 MB / 0.7935 GB, free: 8.395 MB / 0.5762 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001189/1.182, allocations: 0.8145 MB / 0.7943 GB, free: 7.879 MB / 0.5762 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001292/1.183, allocations: 0.918 MB / 0.7952 GB, free: 6.824 MB / 0.5762 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.557e-05/1.183, allocations: 48.59 kB / 0.7953 GB, free: 6.777 MB / 0.5762 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.002003/1.185, allocations: 470.8 kB / 0.7957 GB, free: 6.406 MB / 0.5762 GB
Notification: Performance of pre-optimization done (n=74): time 5.36e-06/1.185, allocations: 0 / 0.7957 GB, free: 6.406 MB / 0.5762 GB
Notification: Performance of matching and sorting (n=74): time 0.0146/1.2, allocations: 4.289 MB / 0.7999 GB, free: 3.086 MB / 0.5762 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.301e-05/1.2, allocations: 141.2 kB / 0.8 GB, free: 2.918 MB / 0.5762 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002656/1.202, allocations: 1.687 MB / 0.8017 GB, free: 1.492 MB / 0.5762 GB
Notification: Performance of collectPreVariables (initialization): time 0.0002555/1.203, allocations: 45.7 kB / 0.8017 GB, free: 1.441 MB / 0.5762 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005947/1.203, allocations: 0.6557 MB / 0.8024 GB, free: 0.7852 MB / 0.5762 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002967/1.204, allocations: 266 kB / 0.8026 GB, free: 0.5273 MB / 0.5762 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005351/1.204, allocations: 274.3 kB / 0.8029 GB, free: 256 kB / 0.5762 GB
Notification: Performance of setup shared object (initialization): time 0.00016/1.204, allocations: 341.9 kB / 0.8032 GB, free: 15.91 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001421/1.206, allocations: 0.9065 MB / 0.8041 GB, free: 15 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00165/1.207, allocations: 1.107 MB / 0.8052 GB, free: 13.82 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002896/1.21, allocations: 1.954 MB / 0.8071 GB, free: 11.83 MB / 0.5919 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.661e-06/1.21, allocations: 7.938 kB / 0.8071 GB, free: 11.82 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=124) (initialization): time 0.004922/1.215, allocations: 2.754 MB / 0.8098 GB, free: 9.078 MB / 0.5919 GB
Notification: Performance of prepare postOptimizeDAE: time 3.02e-05/1.215, allocations: 8 kB / 0.8098 GB, free: 9.07 MB / 0.5919 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.618e-05/1.215, allocations: 4 kB / 0.8098 GB, free: 9.066 MB / 0.5919 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02055/1.236, allocations: 3.546 MB / 0.8133 GB, free: 5.523 MB / 0.5919 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001438/1.237, allocations: 189.3 kB / 0.8134 GB, free: 5.348 MB / 0.5919 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00389/1.241, allocations: 2.266 MB / 0.8157 GB, free: 3.055 MB / 0.5919 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002418/1.244, allocations: 59.92 kB / 0.8157 GB, free: 2.996 MB / 0.5919 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004958/1.244, allocations: 87.92 kB / 0.8158 GB, free: 2.91 MB / 0.5919 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002657/1.247, allocations: 1.232 MB / 0.817 GB, free: 1.676 MB / 0.5919 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001961/1.249, allocations: 1.075 MB / 0.8181 GB, free: 0.5195 MB / 0.5919 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002947/1.252, allocations: 1.902 MB / 0.8199 GB, free: 14.57 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.203e-06/1.252, allocations: 4 kB / 0.8199 GB, free: 14.57 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=124) (initialization_lambda0): time 0.004821/1.257, allocations: 2.369 MB / 0.8222 GB, free: 12.22 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 1.913e-05/1.257, allocations: 4 kB / 0.8222 GB, free: 12.21 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.048e-05/1.257, allocations: 11.94 kB / 0.8222 GB, free: 12.2 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006878/1.258, allocations: 172.1 kB / 0.8224 GB, free: 12.04 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001485/1.259, allocations: 272.2 kB / 0.8227 GB, free: 11.78 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00292/1.262, allocations: 2.346 MB / 0.825 GB, free: 9.312 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001911/1.264, allocations: 64 kB / 0.825 GB, free: 9.25 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001807/1.264, allocations: 87.92 kB / 0.8251 GB, free: 9.164 MB / 0.6075 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 (88):
 * Single equations (assignments): 87
 * Array equations: 0
 * Algorithm blocks: 0
 * 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
   {(3,34)}
Notification: Performance of prepare postOptimizeDAE: time 0.0005875/1.265, allocations: 233.6 kB / 0.8253 GB, free: 8.938 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00042/1.265, allocations: 158.2 kB / 0.8255 GB, free: 8.781 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005693/1.271, allocations: 3.369 MB / 0.8288 GB, free: 5.406 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.235e-05/1.271, allocations: 3.984 kB / 0.8288 GB, free: 5.402 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.12e-06/1.271, allocations: 4 kB / 0.8288 GB, free: 5.398 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006773/1.272, allocations: 239.3 kB / 0.829 GB, free: 5.145 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000276/1.272, allocations: 15.98 kB / 0.829 GB, free: 5.129 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001323/1.273, allocations: 59.94 kB / 0.8291 GB, free: 5.07 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001862/1.273, allocations: 52.53 kB / 0.8291 GB, free: 5.02 MB / 0.6075 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005041/1.278, allocations: 2.015 MB / 0.8311 GB, free: 3.016 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.003755/1.282, allocations: 2.307 MB / 0.8333 GB, free: 0.6875 MB / 0.6075 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0009736/1.283, allocations: 0.6101 MB / 0.8339 GB, free: 80 kB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.001797/1.285, allocations: 1.196 MB / 0.8351 GB, free: 14.88 MB / 0.6231 GB
Notification: Performance of Backend: time 7.11e-07/1.285, allocations: 0 / 0.8351 GB, free: 14.88 MB / 0.6231 GB
Notification: Performance of simCode: created initialization part: time 0.01256/1.298, allocations: 4.15 MB / 0.8392 GB, free: 10.84 MB / 0.6231 GB
Notification: Performance of SimCode: time 0.008075/1.306, allocations: 3.873 MB / 0.8429 GB, free: 6.949 MB / 0.6231 GB
Notification: Performance of Templates: time 0.1198/1.426, allocations: 72.98 MB / 0.9142 GB, free: 14.29 MB / 0.7012 GB
make -j1 -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.makefile
(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 & ./ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Pipes.IdealMixing1.pipe 2>&1)