Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001758/0.001758, allocations: 119.1 kB / 20.45 MB, free: 1.176 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001828/0.001828, allocations: 207.5 kB / 23.73 MB, free: 4.391 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.409/1.409, allocations: 230.5 MB / 257.4 MB, free: 7.738 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2242/0.2242, allocations: 46.94 MB / 360.8 MB, free: 3.902 MB / 286.1 MB
"
[Timeout remaining time 180]
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: "" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_NewFittings_Orifices_ThickEdgedOrifice",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice,fileNamePrefix="ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_NewFittings_Orifices_ThickEdgedOrifice",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.002317/0.002317, allocations: 79.86 kB / 0.4962 GB, free: 7.508 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.333/0.3353, allocations: 66.08 MB / 0.5607 GB, free: 4.016 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice): time 0.2256/0.5608, allocations: 161.7 MB / 0.7186 GB, free: 1.695 MB / 0.545 GB
Notification: Performance of NFInst.instExpressions: time 0.006066/0.5669, allocations: 3.032 MB / 0.7216 GB, free: 14.66 MB / 0.5606 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007031/0.5676, allocations: 19.81 kB / 0.7216 GB, free: 14.64 MB / 0.5606 GB
Notification: Performance of NFTyping.typeComponents: time 0.001028/0.5686, allocations: 313.9 kB / 0.7219 GB, free: 14.33 MB / 0.5606 GB
Notification: Performance of NFTyping.typeBindings: time 0.004331/0.573, allocations: 1.434 MB / 0.7233 GB, free: 12.89 MB / 0.5606 GB
Notification: Performance of NFTyping.typeClassSections: time 0.002291/0.5753, allocations: 0.7371 MB / 0.724 GB, free: 12.16 MB / 0.5606 GB
Notification: Performance of NFFlatten.flatten: time 0.002589/0.5779, allocations: 1.582 MB / 0.7256 GB, free: 10.57 MB / 0.5606 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0006536/0.5785, allocations: 379.7 kB / 0.7259 GB, free: 10.19 MB / 0.5606 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001024/0.5795, allocations: 0.6073 MB / 0.7265 GB, free: 9.582 MB / 0.5606 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0006772/0.5802, allocations: 454 kB / 0.727 GB, free: 9.137 MB / 0.5606 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001024/0.5803, allocations: 55.98 kB / 0.727 GB, free: 9.082 MB / 0.5606 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002812/0.5831, allocations: 0.897 MB / 0.7279 GB, free: 8.184 MB / 0.5606 GB
Notification: Performance of NFScalarize.scalarize: time 0.0002773/0.5834, allocations: 163.4 kB / 0.728 GB, free: 8.023 MB / 0.5606 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004022/0.5838, allocations: 294.8 kB / 0.7283 GB, free: 7.734 MB / 0.5606 GB
Notification: Performance of NFConvertDAE.convert: time 0.002532/0.5863, allocations: 1.452 MB / 0.7297 GB, free: 6.273 MB / 0.5606 GB
Notification: Performance of FrontEnd - DAE generated: time 5.48e-06/0.5863, allocations: 4 kB / 0.7297 GB, free: 6.27 MB / 0.5606 GB
Notification: Performance of FrontEnd: time 2.114e-06/0.5863, allocations: 4 kB / 0.7298 GB, free: 6.266 MB / 0.5606 GB
Notification: Performance of Transformations before backend: time 1.101e-05/0.5864, allocations: 0 / 0.7298 GB, free: 6.266 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: 105
 * Number of variables: 105
Notification: Performance of Generate backend data structure: time 0.002073/0.5884, allocations: 0.9944 MB / 0.7307 GB, free: 5.238 MB / 0.5606 GB
Notification: Performance of prepare preOptimizeDAE: time 5.562e-05/0.5885, allocations: 8.031 kB / 0.7307 GB, free: 5.23 MB / 0.5606 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.0001233/0.5886, allocations: 86.52 kB / 0.7308 GB, free: 5.137 MB / 0.5606 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0009748/0.5896, allocations: 147.5 kB / 0.731 GB, free: 4.992 MB / 0.5606 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0009907/0.5906, allocations: 429.6 kB / 0.7314 GB, free: 4.543 MB / 0.5606 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.217e-05/0.5906, allocations: 40.94 kB / 0.7314 GB, free: 4.504 MB / 0.5606 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 7.81e-05/0.5907, allocations: 40 kB / 0.7314 GB, free: 4.465 MB / 0.5606 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001414/0.5921, allocations: 0.8918 MB / 0.7323 GB, free: 3.461 MB / 0.5606 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.147e-05/0.5921, allocations: 0 / 0.7323 GB, free: 3.461 MB / 0.5606 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.798e-05/0.5922, allocations: 31.92 kB / 0.7323 GB, free: 3.43 MB / 0.5606 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.485e-05/0.5922, allocations: 8 kB / 0.7323 GB, free: 3.422 MB / 0.5606 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001002/0.5932, allocations: 475.6 kB / 0.7328 GB, free: 2.957 MB / 0.5606 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.00313/0.5963, allocations: 1.989 MB / 0.7347 GB, free: 0.8906 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007816/0.5971, allocations: 323.4 kB / 0.7351 GB, free: 0.5664 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000326/0.5974, allocations: 157.3 kB / 0.7352 GB, free: 420 kB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002279/0.5977, allocations: 52.23 kB / 0.7353 GB, free: 368 kB / 0.5606 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.278e-05/0.5977, allocations: 42.78 kB / 0.7353 GB, free: 316 kB / 0.5606 GB
Notification: Performance of pre-optimization done (n=33): time 1.843e-06/0.5977, allocations: 0 / 0.7353 GB, free: 316 kB / 0.5606 GB
Notification: Performance of matching and sorting (n=33): time 0.2624/0.8601, allocations: 0.6492 MB / 0.7359 GB, free: 176.3 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.759e-05/0.8602, allocations: 136.2 kB / 0.7361 GB, free: 176.2 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.000794/0.861, allocations: 0.4951 MB / 0.7365 GB, free: 176 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 4.622e-05/0.861, allocations: 31.92 kB / 0.7366 GB, free: 176 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0001752/0.8612, allocations: 283.2 kB / 0.7368 GB, free: 175.8 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 9.949e-05/0.8613, allocations: 125.8 kB / 0.737 GB, free: 175.7 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00019/0.8615, allocations: 103.9 kB / 0.7371 GB, free: 175.7 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 9.516e-05/0.8616, allocations: 367.1 kB / 0.7374 GB, free: 175.3 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003617/0.862, allocations: 146.1 kB / 0.7376 GB, free: 175.3 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004306/0.8624, allocations: 364.1 kB / 0.7379 GB, free: 175 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.000741/0.8631, allocations: 446.1 kB / 0.7383 GB, free: 174.7 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.831e-06/0.8631, allocations: 4.125 kB / 0.7383 GB, free: 174.7 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=47) (initialization): time 0.0009775/0.8641, allocations: 0.5428 MB / 0.7389 GB, free: 174.5 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 1.883e-05/0.8641, allocations: 11.16 kB / 0.7389 GB, free: 174.5 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.975e-06/0.8641, allocations: 2.719 kB / 0.7389 GB, free: 174.5 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001417/0.8656, allocations: 247.8 kB / 0.7391 GB, free: 174.5 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003244/0.8659, allocations: 103.4 kB / 0.7392 GB, free: 174.5 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0003185/0.8662, allocations: 0.5992 MB / 0.7398 GB, free: 173.9 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003031/0.8665, allocations: 46.77 kB / 0.7398 GB, free: 173.9 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.459e-05/0.8666, allocations: 50.33 kB / 0.7399 GB, free: 173.9 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 15
 * 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 (44):
 * Single equations (assignments): 43
 * 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
   {(1,3)}
Notification: Performance of prepare postOptimizeDAE: time 0.0001924/0.8668, allocations: 190.3 kB / 0.7401 GB, free: 173.8 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 9.652e-05/0.8669, allocations: 60.38 kB / 0.7401 GB, free: 173.7 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001627/0.8685, allocations: 1.088 MB / 0.7412 GB, free: 173.4 MB / 0.5606 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.07e-06/0.8685, allocations: 3.844 kB / 0.7412 GB, free: 173.4 MB / 0.5606 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.989e-06/0.8685, allocations: 6.938 kB / 0.7412 GB, free: 173.4 MB / 0.5606 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.07e-06/0.8685, allocations: 2.969 kB / 0.7412 GB, free: 173.4 MB / 0.5606 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.001151/0.8696, allocations: 0.9345 MB / 0.7421 GB, free: 172.8 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.085e-06/0.8697, allocations: 7.062 kB / 0.7421 GB, free: 172.8 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0001869/0.8698, allocations: 57.31 kB / 0.7422 GB, free: 172.7 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.002826/0.8727, allocations: 445.4 kB / 0.7426 GB, free: 172.5 MB / 0.5606 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.27e-05/0.8727, allocations: 16 kB / 0.7426 GB, free: 172.4 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0002883/0.873, allocations: 0.6077 MB / 0.7432 GB, free: 171.8 MB / 0.5606 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.374e-06/0.873, allocations: 2.203 kB / 0.7432 GB, free: 171.8 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.0006281/0.8736, allocations: 0.5129 MB / 0.7437 GB, free: 171.3 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 9.018e-05/0.8737, allocations: 62.5 kB / 0.7438 GB, free: 171.2 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 8.521e-05/0.8738, allocations: 12 kB / 0.7438 GB, free: 171.2 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0002989/0.8741, allocations: 16.95 kB / 0.7438 GB, free: 171.2 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 5.71e-05/0.8741, allocations: 27.89 kB / 0.7438 GB, free: 171.2 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 2.713e-05/0.8742, allocations: 22.77 kB / 0.7438 GB, free: 171.1 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.0003658/0.8745, allocations: 422.8 kB / 0.7442 GB, free: 170.7 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 9e-08/0.8745, allocations: 0 / 0.7442 GB, free: 170.7 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.0006623/0.8752, allocations: 293.7 kB / 0.7445 GB, free: 170.5 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * 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 (27):
 * Single equations (assignments): 26
 * 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
   {(1,5)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.001218/0.8764, allocations: 1.309 MB / 0.7458 GB, free: 169.2 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.0006615/0.8771, allocations: 361.1 kB / 0.7462 GB, free: 168.8 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 3.026e-06/0.8771, allocations: 0 / 0.7462 GB, free: 168.8 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.0002787/0.8774, allocations: 159.8 kB / 0.7463 GB, free: 168.7 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001422/0.8788, allocations: 362.8 kB / 0.7466 GB, free: 168.3 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004658/0.8834, allocations: 4.941 MB / 0.7515 GB, free: 163.2 MB / 0.5606 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0001544/0.8836, allocations: 259.5 kB / 0.7517 GB, free: 162.9 MB / 0.5606 GB
Notification: Performance of simCode: alias equations: time 0.0007662/0.8844, allocations: 0.5577 MB / 0.7523 GB, free: 162.4 MB / 0.5606 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002905/0.8846, allocations: 235.3 kB / 0.7525 GB, free: 162.1 MB / 0.5606 GB
Notification: Performance of SimCode: time 5.41e-07/0.8846, allocations: 0 / 0.7525 GB, free: 162.1 MB / 0.5606 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.04354/0.9282, allocations: 23.44 MB / 0.7754 GB, free: 139 MB / 0.5606 GB
Notification: Performance of buildModelFMU: Generate platform static: time 12.87/13.79, allocations: 4.828 kB / 0.7754 GB, free: 139 MB / 0.5606 GB
"
[Timeout remaining time 646]
(rm -f ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice.pipe ; mkfifo ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice.pipe ; head -c 1048576 < ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice.pipe >> ../files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice.sim & /home/hudson/saved_omc/OMSimulator/install/bin/OMSimulator -r=ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice_res.mat --tempDir=temp_ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_NewFittings_Orifices_ThickEdgedOrifice_fmu --startTime=0 --stopTime=1.01 --stepSize=0.000201839 --timeout=50 --tolerance=1e-06 ModelicaTest_trunk_ModelicaTest_Fluid_TestComponents_NewFittings_Orifices_ThickEdgedOrifice.fmu > ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice.pipe 2>&1) [Timeout 52.5]
diffSimulationResults("ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Fluid/TestComponents/NewFittings/Orifices/ThickEdgedOrifice/ThickEdgedOrifice.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_trunk_ModelicaTest.Fluid.TestComponents.NewFittings.Orifices.ThickEdgedOrifice.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 16.75851766485721]