Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.Fluid.TestComponents.Valves.TestValveCompressible.conf.json
Using package ModelicaTest with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo)
Using package ModelicaServices with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Fluid.TestComponents.Valves.TestValveCompressible,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|SourceP1.ports.1..m_flow|SourceP1.ports.1..p|SourceP1.ports.1..h_outflow|V1.port_b.m_flow|V1.port_b.p|V1.port_b.h_outflow|V1.minLimiter.y|SinkP1.ports.1..m_flow|SinkP1.ports.1..p|SinkP1.ports.1..h_outflow|Opening.y|downstreamPressure.y",fileNamePrefix="ModelicaTest_3.2.2_ModelicaTest.Fluid.TestComponents.Valves.TestValveCompressible")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.002643/0.002643, allocations: 371.4 kB / 15.97 MB, free: 6.199 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 3.752/3.752, allocations: 388.9 MB / 405.6 MB, free: 10.23 MB / 346.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.003622/0.003622, allocations: 227.5 kB / 451 MB, free: 145.1 MB / 346.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo): time 0.5224/0.5224, allocations: 80.02 MB / 0.5627 GB, free: 19.84 MB / 346.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004677/0.0004679, allocations: 8 kB / 0.6265 GB, free: 96.52 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.0949/0.0954, allocations: 54.87 MB / 0.6801 GB, free: 41.65 MB / 346.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.TestComponents.Valves.TestValveCompressible): time 0.03332/0.1288, allocations: 26.48 MB / 0.706 GB, free: 15.09 MB / 346.7 MB
Notification: Performance of NFInst.instExpressions: time 0.3348/0.4636, allocations: 15.81 MB / 0.7214 GB, free: 13.62 MB / 346.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.000772/0.4645, allocations: 20.78 kB / 0.7214 GB, free: 13.62 MB / 346.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001228/0.4657, allocations: 234.8 kB / 0.7216 GB, free: 13.62 MB / 346.7 MB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:772:36-773:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:770:36-771:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:772:36-773:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/Fluid/Sources.mo:770:36-771:54:writable] Warning: 'each' used when modifying non-array element m_flow.
Notification: Performance of NFTyping.typeBindings: time 0.01312/0.4789, allocations: 2.984 MB / 0.7246 GB, free: 13.6 MB / 346.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01889/0.4978, allocations: 2.999 MB / 0.7275 GB, free: 13.54 MB / 346.7 MB
Notification: Performance of NFFlatten.flatten: time 0.003039/0.5009, allocations: 1.074 MB / 0.7285 GB, free: 13.54 MB / 346.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001132/0.5021, allocations: 227.7 kB / 0.7288 GB, free: 13.52 MB / 346.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002152/0.5043, allocations: 402.3 kB / 0.7291 GB, free: 13.52 MB / 346.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001186/0.5055, allocations: 290.4 kB / 0.7294 GB, free: 13.52 MB / 346.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001967/0.5058, allocations: 20.61 kB / 0.7294 GB, free: 13.52 MB / 346.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.03297/0.5388, allocations: 6.96 MB / 0.7362 GB, free: 13.36 MB / 346.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0003824/0.5392, allocations: 84.17 kB / 0.7363 GB, free: 13.32 MB / 346.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004144/0.5397, allocations: 119.5 kB / 0.7364 GB, free: 13.28 MB / 346.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01229/0.552, allocations: 3.079 MB / 0.7394 GB, free: 11.93 MB / 346.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.736e-06/0.5521, allocations: 0 / 0.7394 GB, free: 11.93 MB / 346.7 MB
Notification: Performance of FrontEnd: time 3.467e-06/0.5521, allocations: 0 / 0.7394 GB, free: 11.93 MB / 346.7 MB
Notification: Performance of Transformations before backend: time 2.174e-05/0.5522, allocations: 1.469 kB / 0.7394 GB, free: 11.93 MB / 346.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 82
 * Number of variables: 82
Notification: Performance of Generate backend data structure: time 0.007332/0.5595, allocations: 1.241 MB / 0.7406 GB, free: 11.09 MB / 346.7 MB
Notification: Performance of prepare preOptimizeDAE: time 7.894e-05/0.5596, allocations: 6.344 kB / 0.7407 GB, free: 11.09 MB / 346.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004633/0.5643, allocations: 236.1 kB / 0.7409 GB, free: 11.01 MB / 346.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001247/0.5656, allocations: 404.1 kB / 0.7413 GB, free: 10.71 MB / 346.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.956e-05/0.5657, allocations: 25.88 kB / 0.7413 GB, free: 10.71 MB / 346.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001191/0.5659, allocations: 31.53 kB / 0.7413 GB, free: 10.71 MB / 346.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.003965/0.5698, allocations: 0.6353 MB / 0.7419 GB, free: 10.45 MB / 346.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.836e-05/0.5699, allocations: 1.219 kB / 0.7419 GB, free: 10.45 MB / 346.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001117/0.5701, allocations: 21.2 kB / 0.742 GB, free: 10.44 MB / 346.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 2.189e-05/0.5701, allocations: 8.969 kB / 0.742 GB, free: 10.44 MB / 346.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.004528/0.5747, allocations: 0.5907 MB / 0.7425 GB, free: 10.29 MB / 346.7 MB
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.006561/0.5813, allocations: 2.686 MB / 0.7452 GB, free: 8.078 MB / 346.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.004856/0.5862, allocations: 0.5678 MB / 0.7457 GB, free: 7.922 MB / 346.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001112/0.5874, allocations: 200.2 kB / 0.7459 GB, free: 7.879 MB / 346.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.2235/0.811, allocations: 55.47 MB / 0.8001 GB, free: 15.96 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.39e-05/0.8111, allocations: 37.25 kB / 0.8001 GB, free: 15.91 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=28): time 3.065e-06/0.8111, allocations: 4 kB / 0.8001 GB, free: 15.91 MB / 410.7 MB
Notification: Performance of matching and sorting (n=28): time 0.004228/0.8153, allocations: 0.8198 MB / 0.8009 GB, free: 15.25 MB / 410.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.066e-05/0.8154, allocations: 110.8 kB / 0.801 GB, free: 15.11 MB / 410.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0006818/0.8161, allocations: 373.6 kB / 0.8014 GB, free: 14.82 MB / 410.7 MB
Notification: Performance of collectPreVariables (initialization): time 7.758e-05/0.8162, allocations: 29.33 kB / 0.8014 GB, free: 14.79 MB / 410.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002229/0.8165, allocations: 240.5 kB / 0.8016 GB, free: 14.61 MB / 410.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001309/0.8166, allocations: 99.31 kB / 0.8017 GB, free: 14.52 MB / 410.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.448e-05/0.8167, allocations: 6.875 kB / 0.8017 GB, free: 14.52 MB / 410.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001723/0.8168, allocations: 350.7 kB / 0.8021 GB, free: 14.19 MB / 410.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006905/0.8175, allocations: 163.1 kB / 0.8022 GB, free: 14.07 MB / 410.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0008032/0.8184, allocations: 325.3 kB / 0.8025 GB, free: 13.74 MB / 410.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007367/0.8191, allocations: 193.4 kB / 0.8027 GB, free: 13.61 MB / 410.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.161e-06/0.8192, allocations: 0 / 0.8027 GB, free: 13.61 MB / 410.7 MB
Notification: Performance of matching and sorting (n=49) (initialization): time 0.001989/0.8212, allocations: 0.5264 MB / 0.8032 GB, free: 13.19 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002079/0.8214, allocations: 228.2 kB / 0.8035 GB, free: 12.91 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.366e-05/0.8214, allocations: 4 kB / 0.8035 GB, free: 12.91 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.681e-05/0.8215, allocations: 8 kB / 0.8035 GB, free: 12.9 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000836/0.8223, allocations: 116.8 kB / 0.8036 GB, free: 12.79 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.698e-05/0.8224, allocations: 11.94 kB / 0.8036 GB, free: 12.78 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007677/0.8231, allocations: 74.12 kB / 0.8037 GB, free: 12.71 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.172e-05/0.8232, allocations: 25.17 kB / 0.8037 GB, free: 12.7 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.494e-05/0.8233, allocations: 4 kB / 0.8037 GB, free: 12.69 MB / 410.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001768/0.8251, allocations: 466.7 kB / 0.8041 GB, free: 12.35 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.447e-05/0.8251, allocations: 12.08 kB / 0.8041 GB, free: 12.34 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.541e-05/0.8251, allocations: 8 kB / 0.8042 GB, free: 12.33 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007622/0.8259, allocations: 113.6 kB / 0.8043 GB, free: 12.23 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.464e-05/0.826, allocations: 11.94 kB / 0.8043 GB, free: 12.21 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006548/0.8266, allocations: 59.41 kB / 0.8043 GB, free: 12.16 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.446e-05/0.8267, allocations: 32.3 kB / 0.8044 GB, free: 12.13 MB / 410.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 21
 * Number of states: 0 ()
 * Number of discrete variables: 4 (SourceP1.medium.phase,SinkP1.medium.phase,V1.state_b.phase,V1.state_a.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (49):
 * Single equations (assignments): 49
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0004155/0.8271, allocations: 252 kB / 0.8046 GB, free: 11.91 MB / 410.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001406/0.8273, allocations: 47.27 kB / 0.8046 GB, free: 11.86 MB / 410.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.004136/0.8314, allocations: 1.956 MB / 0.8066 GB, free: 10.56 MB / 410.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.079e-05/0.8315, allocations: 7.969 kB / 0.8066 GB, free: 10.55 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.635e-06/0.8315, allocations: 0 / 0.8066 GB, free: 10.55 MB / 410.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0005448/0.8321, allocations: 253.6 kB / 0.8068 GB, free: 10.31 MB / 410.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001328/0.8322, allocations: 10.88 kB / 0.8068 GB, free: 10.31 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0006574/0.8329, allocations: 56.67 kB / 0.8069 GB, free: 10.26 MB / 410.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001427/0.8331, allocations: 36.72 kB / 0.8069 GB, free: 10.23 MB / 410.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002569/0.8356, allocations: 1.127 MB / 0.808 GB, free: 9.406 MB / 410.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.002543/0.8382, allocations: 1.178 MB / 0.8092 GB, free: 8.516 MB / 410.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001047/0.8393, allocations: 0.5009 MB / 0.8096 GB, free: 8.246 MB / 410.7 MB
Notification: Performance of sorting global known variables: time 0.0006657/0.84, allocations: 314 kB / 0.8099 GB, free: 8.008 MB / 410.7 MB
Notification: Performance of Backend: time 8.41e-07/0.84, allocations: 0 / 0.8099 GB, free: 8.008 MB / 410.7 MB
Notification: Performance of simCode: created initialization part: time 0.01251/0.8526, allocations: 2.004 MB / 0.8119 GB, free: 6.289 MB / 410.7 MB
Notification: Performance of SimCode: time 0.003994/0.8566, allocations: 1.906 MB / 0.8138 GB, free: 4.449 MB / 410.7 MB
Notification: Performance of Templates: time 0.1125/0.9691, allocations: 45.64 MB / 0.8583 GB, free: 6.957 MB / 458.7 MB
""

Variables in the reference:time,SourceP1.ports[1].m_flow,SourceP1.ports[1].p,SourceP1.ports[1].h_outflow,V1.port_b.m_flow,V1.port_b.p,V1.port_b.h_outflow,V1.minLimiter.y,SinkP1.ports[1].m_flow,SinkP1.ports[1].p,SinkP1.ports[1].h_outflow,Opening.y,downstreamPressure.y

Variables in the result:Opening.k,Opening.y,SinkP1.T,SinkP1.X[1],SinkP1.flowDirection,SinkP1.medium.preferredMediumStates,SinkP1.medium.standardOrderComponents,SinkP1.nPorts,SinkP1.p,SinkP1.ports[1].h_outflow,SinkP1.ports[1].m_flow,SinkP1.ports[1].p,SourceP1.T,SourceP1.X[1],SourceP1.flowDirection,SourceP1.medium.preferredMediumStates,SourceP1.medium.standardOrderComponents,SourceP1.nPorts,SourceP1.p,SourceP1.p_in_internal,SourceP1.ports[1].h_outflow,SourceP1.ports[1].m_flow,SourceP1.ports[1].p,V1.Av,V1.Cv,V1.CvData,V1.Fxt_full,V1.Fxt_nominal,V1.Kv,V1.Y_nominal,V1.allowFlowReversal,V1.checkValve,V1.dp_nominal,V1.dp_small,V1.dp_start,V1.dp_turbulent,V1.filteredOpening,V1.leakageOpening,V1.m_flow,V1.m_flow_nominal,V1.m_flow_small,V1.m_flow_start,V1.minLimiter.u,V1.minLimiter.uMin,V1.minLimiter.y,V1.opening,V1.opening_actual,V1.opening_nominal,V1.p_nominal,V1.port_a_exposesState,V1.port_b.h_outflow,V1.port_b.m_flow,V1.port_b.p,V1.port_b_exposesState,V1.rho_nominal,V1.riseTime,V1.showDesignFlowDirection,V1.show_T,V1.show_V_flow,V1.use_Re,V1.x_nominal,V1.xs_nominal,downstreamPressure.amplitude,downstreamPressure.freqHz,downstreamPressure.offset,downstreamPressure.phase,downstreamPressure.startTime,downstreamPressure.y,system.T_ambient,system.T_start,system.allowFlowReversal,system.dp_small,system.energyDynamics,system.eps_m_flow,system.g,system.m_flow_nominal,system.m_flow_small,system.m_flow_start,system.massDynamics,system.momentumDynamics,system.p_ambient,system.p_start,system.substanceDynamics,system.traceDynamics,system.use_eps_Re,time