Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.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.001248/0.001248, allocations: 114 kB / 21.18 MB, free: 0.7422 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.001412/0.001412, allocations: 214.1 kB / 24.48 MB, free: 4.191 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.432/1.432, allocations: 230.2 MB / 257.8 MB, free: 8.488 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2269/0.2269, allocations: 46.88 MB / 361.1 MB, free: 4.613 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/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.Valves.TestValveCharacteristics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|valve_linear.port_b.m_flow|valve_linear.port_b.p|valve_linear.port_b.h_outflow|valve_linear.minLimiter.y|sink1.ports.1..m_flow|sink1.ports.1..p|sink1.ports.1..h_outflow|opening.y|valve_constant.port_b.m_flow|valve_constant.port_b.p|valve_constant.port_b.h_outflow|valve_constant.minLimiter.y|valve_quadratic.port_b.m_flow|valve_quadratic.port_b.p|valve_quadratic.port_b.h_outflow|valve_quadratic.minLimiter.y|sink2.ports.1..m_flow|sink2.ports.1..p|sink2.ports.1..h_outflow|sink3.ports.1..m_flow|sink3.ports.1..p|sink3.ports.1..h_outflow|valve_equalPercentage.port_b.m_flow|valve_equalPercentage.port_b.p|valve_equalPercentage.port_b.h_outflow|valve_equalPercentage.minLimiter.y|sink4.ports.1..m_flow|sink4.ports.1..p|sink4.ports.1..h_outflow",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics")
translateModel(ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5004,variableFilter="time|valve_linear.port_b.m_flow|valve_linear.port_b.p|valve_linear.port_b.h_outflow|valve_linear.minLimiter.y|sink1.ports.1..m_flow|sink1.ports.1..p|sink1.ports.1..h_outflow|opening.y|valve_constant.port_b.m_flow|valve_constant.port_b.p|valve_constant.port_b.h_outflow|valve_constant.minLimiter.y|valve_quadratic.port_b.m_flow|valve_quadratic.port_b.p|valve_quadratic.port_b.h_outflow|valve_quadratic.minLimiter.y|sink2.ports.1..m_flow|sink2.ports.1..p|sink2.ports.1..h_outflow|sink3.ports.1..m_flow|sink3.ports.1..p|sink3.ports.1..h_outflow|valve_equalPercentage.port_b.m_flow|valve_equalPercentage.port_b.p|valve_equalPercentage.port_b.h_outflow|valve_equalPercentage.minLimiter.y|sink4.ports.1..m_flow|sink4.ports.1..p|sink4.ports.1..h_outflow",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics") [Timeout 660]
"Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Notification: Performance of FrontEnd - loaded program: time 0.002342/0.002342, allocations: 75.88 kB / 0.4968 GB, free: 7.785 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3187/0.3211, allocations: 65.99 MB / 0.5612 GB, free: 5 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics): time 0.09121/0.4123, allocations: 83.76 MB / 0.643 GB, free: 0.957 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.04055/0.4528, allocations: 28.63 MB / 0.671 GB, free: 4.238 MB / 0.4981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002334/0.4552, allocations: 47.62 kB / 0.671 GB, free: 4.191 MB / 0.4981 GB
Notification: Performance of NFTyping.typeComponents: time 0.003421/0.4586, allocations: 0.982 MB / 0.672 GB, free: 3.203 MB / 0.4981 GB
Notification: Performance of NFTyping.typeBindings: time 0.01663/0.4752, allocations: 5.138 MB / 0.677 GB, free: 14.06 MB / 0.5137 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01672/0.4919, allocations: 5.74 MB / 0.6826 GB, free: 8.328 MB / 0.5137 GB
Notification: Performance of NFFlatten.flatten: time 0.005907/0.4979, allocations: 3.714 MB / 0.6862 GB, free: 4.602 MB / 0.5137 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001645/0.4995, allocations: 0.8405 MB / 0.687 GB, free: 3.738 MB / 0.5137 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003069/0.5026, allocations: 1.444 MB / 0.6884 GB, free: 2.289 MB / 0.5137 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001867/0.5044, allocations: 1.105 MB / 0.6895 GB, free: 1.18 MB / 0.5137 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002803/0.5047, allocations: 132 kB / 0.6896 GB, free: 1.051 MB / 0.5137 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01796/0.5227, allocations: 8.577 MB / 0.698 GB, free: 8.465 MB / 0.5294 GB
Notification: Performance of NFScalarize.scalarize: time 0.0008366/0.5235, allocations: 410.6 kB / 0.6984 GB, free: 8.062 MB / 0.5294 GB
Notification: Performance of NFVerifyModel.verify: time 0.001375/0.5249, allocations: 0.8672 MB / 0.6993 GB, free: 7.191 MB / 0.5294 GB
Notification: Performance of NFConvertDAE.convert: time 0.01676/0.5416, allocations: 6.919 MB / 0.706 GB, free: 260 kB / 0.5294 GB
Notification: Performance of FrontEnd - DAE generated: time 6.813e-06/0.5417, allocations: 0 / 0.706 GB, free: 260 kB / 0.5294 GB
Notification: Performance of FrontEnd: time 1.563e-06/0.5417, allocations: 4 kB / 0.706 GB, free: 256 kB / 0.5294 GB
Notification: Performance of Transformations before backend: time 3.217e-05/0.5417, allocations: 0 / 0.706 GB, free: 256 kB / 0.5294 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 301
 * Number of variables: 301
Notification: Performance of Generate backend data structure: time 0.008143/0.5498, allocations: 2.815 MB / 0.7088 GB, free: 13.37 MB / 0.545 GB
Notification: Performance of prepare preOptimizeDAE: time 5.177e-05/0.5499, allocations: 8.031 kB / 0.7088 GB, free: 13.36 MB / 0.545 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.007469/0.5574, allocations: 0.8623 MB / 0.7096 GB, free: 12.5 MB / 0.545 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002345/0.5597, allocations: 0.9719 MB / 0.7106 GB, free: 11.48 MB / 0.545 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001338/0.5598, allocations: 110.2 kB / 0.7107 GB, free: 11.37 MB / 0.545 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001952/0.56, allocations: 120 kB / 0.7108 GB, free: 11.25 MB / 0.545 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.006318/0.5663, allocations: 2.228 MB / 0.713 GB, free: 8.867 MB / 0.545 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.675e-05/0.5664, allocations: 7.938 kB / 0.713 GB, free: 8.859 MB / 0.545 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001786/0.5666, allocations: 60 kB / 0.713 GB, free: 8.801 MB / 0.545 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.975e-05/0.5666, allocations: 35.92 kB / 0.7131 GB, free: 8.766 MB / 0.545 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.006484/0.5731, allocations: 2.092 MB / 0.7151 GB, free: 6.664 MB / 0.545 GB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.01492/0.588, allocations: 9.991 MB / 0.7249 GB, free: 11.92 MB / 0.5606 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005824/0.5938, allocations: 1.574 MB / 0.7264 GB, free: 10.33 MB / 0.5606 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001509/0.5953, allocations: 0.5307 MB / 0.7269 GB, free: 9.801 MB / 0.5606 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.322/0.9173, allocations: 28.8 MB / 0.755 GB, free: 149.5 MB / 0.5606 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.68e-05/0.9173, allocations: 47.48 kB / 0.7551 GB, free: 149.4 MB / 0.5606 GB
Notification: Performance of pre-optimization done (n=88): time 2.595e-06/0.9173, allocations: 0 / 0.7551 GB, free: 149.4 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=88): time 0.008708/0.926, allocations: 2.747 MB / 0.7578 GB, free: 148.2 MB / 0.5606 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.643e-05/0.9261, allocations: 273.3 kB / 0.758 GB, free: 147.9 MB / 0.5606 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001049/0.9272, allocations: 1.071 MB / 0.7591 GB, free: 147.3 MB / 0.5606 GB
Notification: Performance of collectPreVariables (initialization): time 9.145e-05/0.9272, allocations: 41.52 kB / 0.7591 GB, free: 147.3 MB / 0.5606 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003206/0.9276, allocations: 0.618 MB / 0.7597 GB, free: 146.8 MB / 0.5606 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001793/0.9277, allocations: 316.8 kB / 0.76 GB, free: 146.6 MB / 0.5606 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002749/0.928, allocations: 254 kB / 0.7603 GB, free: 146.4 MB / 0.5606 GB
Notification: Performance of setup shared object (initialization): time 6.716e-05/0.9281, allocations: 352 kB / 0.7606 GB, free: 146.1 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001095/0.9292, allocations: 486.1 kB / 0.7611 GB, free: 145.8 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001319/0.9305, allocations: 0.8737 MB / 0.7619 GB, free: 145.1 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002311/0.9328, allocations: 1.305 MB / 0.7632 GB, free: 143.6 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.233e-06/0.9328, allocations: 8 kB / 0.7632 GB, free: 143.6 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=141) (initialization): time 0.003049/0.9359, allocations: 1.469 MB / 0.7646 GB, free: 142.2 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 2.072e-05/0.9359, allocations: 16.25 kB / 0.7646 GB, free: 142.1 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.2e-05/0.9359, allocations: 8 kB / 0.7647 GB, free: 142.1 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.034e-05/0.9359, allocations: 20 kB / 0.7647 GB, free: 142.1 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001026/0.937, allocations: 339.2 kB / 0.765 GB, free: 141.8 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.94e-05/0.937, allocations: 19.94 kB / 0.765 GB, free: 141.8 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001075/0.9381, allocations: 207.5 kB / 0.7652 GB, free: 141.6 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.393e-05/0.9381, allocations: 63.98 kB / 0.7653 GB, free: 141.5 MB / 0.5606 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001347/0.9395, allocations: 0.6703 MB / 0.7659 GB, free: 140.9 MB / 0.5606 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.00117/0.9407, allocations: 0.8615 MB / 0.7668 GB, free: 139.8 MB / 0.5606 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002189/0.9428, allocations: 1.276 MB / 0.768 GB, free: 138.4 MB / 0.5606 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 6.292e-06/0.9429, allocations: 4 kB / 0.768 GB, free: 138.4 MB / 0.5606 GB
Notification: Performance of matching and sorting (n=141) (initialization_lambda0): time 0.003/0.9459, allocations: 1.445 MB / 0.7694 GB, free: 136.9 MB / 0.5606 GB
Notification: Performance of prepare postOptimizeDAE: time 2.061e-05/0.9459, allocations: 8 kB / 0.7694 GB, free: 136.9 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.447e-05/0.9459, allocations: 12.91 kB / 0.7695 GB, free: 136.9 MB / 0.5606 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.269e-05/0.9459, allocations: 23.94 kB / 0.7695 GB, free: 136.9 MB / 0.5606 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001611/0.9475, allocations: 323.5 kB / 0.7698 GB, free: 136.6 MB / 0.5606 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.84e-05/0.9475, allocations: 27.86 kB / 0.7698 GB, free: 136.6 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00174/0.9493, allocations: 149.6 kB / 0.77 GB, free: 136.4 MB / 0.5606 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001302/0.9494, allocations: 67.97 kB / 0.77 GB, free: 136.4 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 51
 * Number of states: 0 ()
 * Number of discrete variables: 16 (sink2.medium.phase,source2.medium.phase,sink4.medium.phase,source4.medium.phase,sink3.medium.phase,source3.medium.phase,sink1.medium.phase,source1.medium.phase,valve_equalPercentage.state_b.phase,valve_equalPercentage.state_a.phase,valve_quadratic.state_b.phase,valve_quadratic.state_a.phase,valve_constant.state_b.phase,valve_constant.state_a.phase,valve_linear.state_b.phase,valve_linear.state_a.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (141):
 * Single equations (assignments): 141
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.000471/0.9499, allocations: 261.3 kB / 0.7703 GB, free: 136.1 MB / 0.5606 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003951/0.9503, allocations: 151 kB / 0.7704 GB, free: 136 MB / 0.5606 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.009655/0.9599, allocations: 6.608 MB / 0.7769 GB, free: 129.4 MB / 0.5606 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.651e-05/0.96, allocations: 3.984 kB / 0.7769 GB, free: 129.4 MB / 0.5606 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.268e-05/0.96, allocations: 3.984 kB / 0.7769 GB, free: 129.4 MB / 0.5606 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001169/0.9611, allocations: 484 kB / 0.7773 GB, free: 129 MB / 0.5606 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005278/0.9617, allocations: 158.7 kB / 0.7775 GB, free: 128.9 MB / 0.5606 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001897/0.9636, allocations: 139.8 kB / 0.7776 GB, free: 128.8 MB / 0.5606 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002924/0.9639, allocations: 108.8 kB / 0.7777 GB, free: 128.7 MB / 0.5606 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005917/0.9698, allocations: 2.969 MB / 0.7806 GB, free: 125.7 MB / 0.5606 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.006025/0.9758, allocations: 3.112 MB / 0.7837 GB, free: 122.6 MB / 0.5606 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002308/0.9781, allocations: 1.092 MB / 0.7847 GB, free: 121.5 MB / 0.5606 GB
Notification: Performance of sorting global known variables: time 0.002848/0.981, allocations: 1.557 MB / 0.7862 GB, free: 119.9 MB / 0.5606 GB
Notification: Performance of Backend: time 8.41e-07/0.981, allocations: 0 / 0.7862 GB, free: 119.9 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.01582/0.9968, allocations: 3.53 MB / 0.7897 GB, free: 116.6 MB / 0.5606 GB
Notification: Performance of SimCode: time 0.00598/1.003, allocations: 4.916 MB / 0.7945 GB, free: 111.7 MB / 0.5606 GB
Notification: Performance of Templates: time 0.0873/1.09, allocations: 79.61 MB / 0.8722 GB, free: 32.37 MB / 0.5606 GB
"
[Timeout remaining time 659]
make -j1 -f ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.sim & ./ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.pipe 2>&1) [Timeout 480]
diffSimulationResults("ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics_res.mat","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/Fluid/TestComponents/Valves/TestValveCharacteristics/TestValveCharacteristics.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork_2/OpenModelicaLibraryTesting/files/ModelicaTest_4.1.0-beta.om_ModelicaTest.Fluid.TestComponents.Valves.TestValveCharacteristics.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: 10.303020506165922]