Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice.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: translateModel(ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=20000,variableFilter="time|orifice1.port_b.m_flow|orifice1.port_b.p|orifice1.port_b.h_outflow|orifice2.port_b.m_flow|orifice2.port_b.p|orifice2.port_b.h_outflow",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice")
translateModel(ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice,tolerance=1e-06,outputFormat="mat",numberOfIntervals=20000,variableFilter="time|orifice1.port_b.m_flow|orifice1.port_b.p|orifice1.port_b.h_outflow|orifice2.port_b.m_flow|orifice2.port_b.p|orifice2.port_b.h_outflow",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001482/0.001482, allocations: 198 kB / 17.08 MB, free: 5.082 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.241/1.241, allocations: 227.2 MB / 245 MB, free: 5.891 MB / 202.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.000958/0.000958, allocations: 106.2 kB / 297.3 MB, free: 5.953 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.3146/0.3146, allocations: 45.23 MB / 394.7 MB, free: 31.73 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0002326/0.0002326, allocations: 7.984 kB / 468.4 MB, free: 7.711 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.302/0.3022, allocations: 63.25 MB / 0.5192 GB, free: 37.25 MB / 378.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.9309/1.233, allocations: 478.3 MB / 0.9863 GB, free: 134.9 MB / 0.5417 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002422/1.233, allocations: 83.95 kB / 0.9863 GB, free: 134.8 MB / 0.5417 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Fluid/Interfaces.mo:714:9-719:39:writable] Notification: From here:
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Fluid/Interfaces.mo:306:3-308:69:writable] Warning: Inherited elements are not identical: bug: https://trac.modelica.org/Modelica/ticket/627
        first:  Medium.MassFlowRate m_flow(min = if allowFlowReversal then -Modelica.Constants.inf else 0, start = m_flow_start, stateSelect = if momentumDynamics == Modelica.Fluid.Types.Dynamics.SteadyState then StateSelect.default else StateSelect.prefer) "Mass flow rates between states"
        second: Medium.MassFlowRate m_flow(min = if allowFlowReversal then -Modelica.Constants.inf else 0, start = m_flow_start) "Mass flow rate in design flow direction"
Continue ....
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Fluid/Interfaces.mo:714:9-719:39:writable] Notification: From here:
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/Fluid/Interfaces.mo:306:3-308:69:writable] Warning: Inherited elements are not identical: bug: https://trac.modelica.org/Modelica/ticket/627
        first:  Medium.MassFlowRate m_flow(min = if allowFlowReversal then -Modelica.Constants.inf else 0, start = m_flow_start, stateSelect = if momentumDynamics == Modelica.Fluid.Types.Dynamics.SteadyState then StateSelect.default else StateSelect.prefer) "Mass flow rates between states"
        second: Medium.MassFlowRate m_flow(min = if allowFlowReversal then -Modelica.Constants.inf else 0, start = m_flow_start) "Mass flow rate in design flow direction"
Continue ....
Notification: Performance of FrontEnd - DAE generated: time 0.601/1.835, allocations: 190.8 MB / 1.173 GB, free: 133.5 MB / 0.5417 GB
Notification: Performance of FrontEnd: time 1.783e-06/1.835, allocations: 0 / 1.173 GB, free: 133.5 MB / 0.5417 GB
Notification: Performance of Transformations before backend: time 5.599e-05/1.835, allocations: 18.75 kB / 1.173 GB, free: 133.5 MB / 0.5417 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 110
 * Number of variables: 110
Notification: Performance of Generate backend data structure: time 0.002477/1.837, allocations: 1.081 MB / 1.174 GB, free: 132.9 MB / 0.5417 GB
Notification: Performance of prepare preOptimizeDAE: time 3.774e-05/1.837, allocations: 8.094 kB / 1.174 GB, free: 132.9 MB / 0.5417 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001412/1.839, allocations: 175.7 kB / 1.174 GB, free: 132.8 MB / 0.5417 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001168/1.84, allocations: 0.5509 MB / 1.174 GB, free: 132.5 MB / 0.5417 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.373e-05/1.84, allocations: 34.41 kB / 1.175 GB, free: 132.5 MB / 0.5417 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 9.15e-05/1.84, allocations: 43.25 kB / 1.175 GB, free: 132.4 MB / 0.5417 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0009366/1.841, allocations: 0.6178 MB / 1.175 GB, free: 132.1 MB / 0.5417 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.545e-05/1.841, allocations: 3.938 kB / 1.175 GB, free: 132.1 MB / 0.5417 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.88e-05/1.841, allocations: 23.38 kB / 1.175 GB, free: 132.1 MB / 0.5417 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.044e-05/1.841, allocations: 14.92 kB / 1.175 GB, free: 132.1 MB / 0.5417 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0006639/1.842, allocations: 491.9 kB / 1.176 GB, free: 131.9 MB / 0.5417 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.002761/1.844, allocations: 2.672 MB / 1.178 GB, free: 130 MB / 0.5417 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0004423/1.845, allocations: 291.9 kB / 1.179 GB, free: 129.9 MB / 0.5417 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002719/1.845, allocations: 346.1 kB / 1.179 GB, free: 129.5 MB / 0.5417 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0003818/1.846, allocations: 343.7 kB / 1.179 GB, free: 129.3 MB / 0.5417 GB
Notification: Performance of pre-optimization done (n=35): time 2.094e-06/1.846, allocations: 0 / 1.179 GB, free: 129.3 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=35): time 0.0009883/1.847, allocations: 0.7214 MB / 1.18 GB, free: 128.9 MB / 0.5417 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.243e-05/1.847, allocations: 304 kB / 1.18 GB, free: 128.6 MB / 0.5417 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005019/1.847, allocations: 0.5472 MB / 1.181 GB, free: 128.3 MB / 0.5417 GB
Notification: Performance of collectPreVariables (initialization): time 4.552e-05/1.847, allocations: 33.58 kB / 1.181 GB, free: 128.3 MB / 0.5417 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001672/1.847, allocations: 333.3 kB / 1.181 GB, free: 128 MB / 0.5417 GB
Notification: Performance of collectInitialBindings (initialization): time 8.05e-05/1.847, allocations: 116.7 kB / 1.181 GB, free: 127.9 MB / 0.5417 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.058e-05/1.847, allocations: 15.22 kB / 1.181 GB, free: 127.9 MB / 0.5417 GB
Notification: Performance of setup shared object (initialization): time 7.525e-05/1.848, allocations: 365.8 kB / 1.182 GB, free: 127.6 MB / 0.5417 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000241/1.848, allocations: 180.2 kB / 1.182 GB, free: 127.5 MB / 0.5417 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003107/1.848, allocations: 385.2 kB / 1.182 GB, free: 127.2 MB / 0.5417 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0002978/1.848, allocations: 246.7 kB / 1.182 GB, free: 127.1 MB / 0.5417 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.036e-06/1.848, allocations: 0 / 1.182 GB, free: 127.1 MB / 0.5417 GB
Notification: Performance of matching and sorting (n=60) (initialization): time 0.0008867/1.849, allocations: 0.6766 MB / 1.183 GB, free: 126.8 MB / 0.5417 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0003592/1.85, allocations: 2.031 MB / 1.185 GB, free: 124.6 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.012e-05/1.85, allocations: 3.938 kB / 1.185 GB, free: 124.6 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.247e-05/1.85, allocations: 7.812 kB / 1.185 GB, free: 124.6 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.006666/1.856, allocations: 0.6093 MB / 1.186 GB, free: 124.6 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0003574/1.857, allocations: 0.6582 MB / 1.186 GB, free: 124 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000518/1.857, allocations: 81.33 kB / 1.186 GB, free: 124 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.878e-05/1.857, allocations: 51.84 kB / 1.186 GB, free: 124 MB / 0.5417 GB
Notification: Performance of prepare postOptimizeDAE: time 8.296e-06/1.857, allocations: 3.406 kB / 1.186 GB, free: 124 MB / 0.5417 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0007552/1.858, allocations: 0.5553 MB / 1.187 GB, free: 123.7 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.793e-06/1.858, allocations: 7.203 kB / 1.187 GB, free: 123.7 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (initialization): time 8.005e-06/1.858, allocations: 14.91 kB / 1.187 GB, free: 123.7 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003759/1.859, allocations: 123.8 kB / 1.187 GB, free: 123.7 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 8.165e-06/1.859, allocations: 15.69 kB / 1.187 GB, free: 123.7 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004287/1.859, allocations: 69.5 kB / 1.187 GB, free: 123.7 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.591e-05/1.859, allocations: 49.44 kB / 1.187 GB, free: 123.7 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 23
 * Number of states: 0 ()
 * Number of discrete variables: 7 ($whenCondition1,p_table.a,p_table.b,p_table.last,$PRE.p_table.nextEvent,p_table.nextEvent,p_table.nextEventScaled)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (55):
 * Single equations (assignments): 53
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * 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: 1 {1}
 * Without analytic Jacobian: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0002583/1.859, allocations: 311.5 kB / 1.187 GB, free: 123.4 MB / 0.5417 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 8.594e-05/1.859, allocations: 70.41 kB / 1.188 GB, free: 123.4 MB / 0.5417 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001741/1.861, allocations: 1.196 MB / 1.189 GB, free: 123 MB / 0.5417 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.148e-06/1.861, allocations: 3.969 kB / 1.189 GB, free: 123 MB / 0.5417 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.228e-06/1.861, allocations: 0 / 1.189 GB, free: 123 MB / 0.5417 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 4.718e-06/1.861, allocations: 6.188 kB / 1.189 GB, free: 123 MB / 0.5417 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001837/1.863, allocations: 2.296 MB / 1.191 GB, free: 121.1 MB / 0.5417 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.437e-06/1.863, allocations: 0 / 1.191 GB, free: 121.1 MB / 0.5417 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00181/1.865, allocations: 213.3 kB / 1.191 GB, free: 121.1 MB / 0.5417 GB
Notification: Performance of postOpt tearingSystem (simulation): time 4.501e-05/1.865, allocations: 3.812 kB / 1.191 GB, free: 121.1 MB / 0.5417 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.159e-05/1.865, allocations: 31.25 kB / 1.191 GB, free: 121.1 MB / 0.5417 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0002919/1.865, allocations: 0.6453 MB / 1.192 GB, free: 120.5 MB / 0.5417 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.695e-06/1.865, allocations: 3.688 kB / 1.192 GB, free: 120.5 MB / 0.5417 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0008611/1.866, allocations: 0.8487 MB / 1.193 GB, free: 119.9 MB / 0.5417 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00017/1.866, allocations: 155.6 kB / 1.193 GB, free: 119.7 MB / 0.5417 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001281/1.867, allocations: 16.27 kB / 1.193 GB, free: 119.7 MB / 0.5417 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000416/1.867, allocations: 32.55 kB / 1.193 GB, free: 119.7 MB / 0.5417 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.588e-05/1.867, allocations: 45.78 kB / 1.193 GB, free: 119.7 MB / 0.5417 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.7e-05/1.867, allocations: 36.67 kB / 1.193 GB, free: 119.7 MB / 0.5417 GB
Notification: Performance of sorting global known variables: time 0.0004321/1.868, allocations: 448.9 kB / 1.193 GB, free: 119.5 MB / 0.5417 GB
Notification: Performance of sort global known variables: time 1.313e-06/1.868, allocations: 0 / 1.193 GB, free: 119.5 MB / 0.5417 GB
Notification: Performance of remove unused functions: time 0.002/1.87, allocations: 0.589 MB / 1.194 GB, free: 119.3 MB / 0.5417 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 12
 * Number of states: 0 ()
 * Number of discrete variables: 6 ($whenCondition1,p_table.a,p_table.b,p_table.last,p_table.nextEvent,p_table.nextEventScaled)
 * Number of discrete states: 6 (p_table.nextEvent,p_table.last,p_table.nextEventScaled,p_table.b,p_table.a,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (37):
 * Single equations (assignments): 35
 * Array equations: 0
 * Algorithm blocks: 1
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * 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: 1 {1}
 * Without analytic Jacobian: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.002455/1.872, allocations: 1.103 MB / 1.195 GB, free: 119.1 MB / 0.5417 GB
Notification: Performance of simCode: created initialization part: time 0.01189/1.884, allocations: 1.641 MB / 1.197 GB, free: 118.7 MB / 0.5417 GB
Notification: Performance of simCode: created event and clocks part: time 5.24e-06/1.884, allocations: 1.531 kB / 1.197 GB, free: 118.7 MB / 0.5417 GB
Notification: Performance of simCode: created simulation system equations: time 0.00285/1.887, allocations: 486.4 kB / 1.197 GB, free: 118.5 MB / 0.5417 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001389/1.888, allocations: 303 kB / 1.197 GB, free: 118.5 MB / 0.5417 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001596/1.89, allocations: 1.281 MB / 1.199 GB, free: 117.7 MB / 0.5417 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00028/1.89, allocations: 0.903 MB / 1.2 GB, free: 117 MB / 0.5417 GB
Notification: Performance of simCode: alias equations: time 0.001705/1.892, allocations: 0.9885 MB / 1.2 GB, free: 116.9 MB / 0.5417 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003167/1.892, allocations: 111.2 kB / 1.201 GB, free: 116.9 MB / 0.5417 GB
Notification: Performance of SimCode: time 4.21e-07/1.892, allocations: 0 / 1.201 GB, free: 116.9 MB / 0.5417 GB
Notification: Performance of Templates: time 0.0296/1.922, allocations: 25.33 MB / 1.225 GB, free: 106.8 MB / 0.5417 GB
make -j1 -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice.makefile
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice.sim & ./ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.Fittings.TestSharpEdgedOrifice.pipe 2>&1)