Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.Fluid.Dissipation.Verifications.HeatTransfer.StraightPipe.kc_laminar.conf.json
Using package ModelicaTest with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo)
Using package ModelicaServices with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: translateModel(ModelicaTest.Fluid.Dissipation.Verifications.HeatTransfer.StraightPipe.kc_laminar,tolerance=1e-07,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|cp.1.|cp.2.|cp.3.|eta.1.|eta.2.|eta.3.|lambda.1.|lambda.2.|lambda.3.|rho.1.|rho.2.|rho.3.|m_flow.1.|m_flow.2.|m_flow.3.|Re_1.1.|Re_1.2.|Re_1.3.|Nu_1.1.|Nu_1.2.|Nu_1.3.|Nu_2.1.|Nu_2.2.|Nu_2.3.|Nu_3.1.|Nu_3.2.|Nu_3.3.|Nu_4.1.|Nu_4.2.|Nu_4.3.|Re|Pr.1.|Pr.2.|Pr.3.|input_mflow_0.y|input_mflow_1.y|input_mflow_2.y",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.Fluid.Dissipation.Verifications.HeatTransfer.StraightPipe.kc_laminar")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.00436/0.004364, allocations: 353 kB / 15.95 MB, free: 6.215 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 3.706/3.706, allocations: 341.5 MB / 358.2 MB, free: 12.63 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.003512/0.003511, allocations: 229.1 kB / 397.9 MB, free: 4.984 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.5142/0.5142, allocations: 76.08 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004647/0.0004649, allocations: 12 kB / 0.5592 GB, free: 53.45 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08393/0.08443, allocations: 48.71 MB / 0.6068 GB, free: 4.629 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.Fluid.Dissipation.Verifications.HeatTransfer.StraightPipe.kc_laminar): time 0.002699/0.08718, allocations: 1.829 MB / 0.6086 GB, free: 2.785 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.002102/0.08934, allocations: 1.041 MB / 0.6096 GB, free: 1.742 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002247/0.08961, allocations: 3.938 kB / 0.6096 GB, free: 1.738 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.0003132/0.08994, allocations: 51.72 kB / 0.6096 GB, free: 1.688 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.0002999/0.09026, allocations: 99.36 kB / 0.6097 GB, free: 1.59 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.0006762/0.09095, allocations: 139.6 kB / 0.6099 GB, free: 1.453 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.3228/0.4137, allocations: 0.5049 MB / 0.6103 GB, free: 88.64 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.000169/0.414, allocations: 56.12 kB / 0.6104 GB, free: 88.64 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.0003995/0.4144, allocations: 162.8 kB / 0.6106 GB, free: 88.6 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.000376/0.4148, allocations: 200.9 kB / 0.6107 GB, free: 88.55 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 6.483e-05/0.4148, allocations: 11.62 kB / 0.6108 GB, free: 88.55 MB / 362.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.0008624/0.4157, allocations: 309.7 kB / 0.6111 GB, free: 88.54 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0001544/0.4159, allocations: 96.5 kB / 0.6111 GB, free: 88.52 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0001568/0.4161, allocations: 87.72 kB / 0.6112 GB, free: 88.48 MB / 362.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.0007074/0.4168, allocations: 368.9 kB / 0.6116 GB, free: 88.44 MB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.13e-06/0.4168, allocations: 2.406 kB / 0.6116 GB, free: 88.44 MB / 362.7 MB
Notification: Performance of FrontEnd: time 1.883e-06/0.4168, allocations: 0 / 0.6116 GB, free: 88.44 MB / 362.7 MB
Notification: Performance of Transformations before backend: time 8.085e-06/0.4168, allocations: 1.281 kB / 0.6116 GB, free: 88.44 MB / 362.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 122
 * Number of variables: 122
Notification: Performance of Generate backend data structure: time 0.001646/0.4185, allocations: 0.6926 MB / 0.6123 GB, free: 87.95 MB / 362.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.369e-05/0.4186, allocations: 9.344 kB / 0.6123 GB, free: 87.95 MB / 362.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0001512/0.4187, allocations: 46.56 kB / 0.6123 GB, free: 87.93 MB / 362.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0004952/0.4192, allocations: 299.4 kB / 0.6126 GB, free: 87.69 MB / 362.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.79e-05/0.4193, allocations: 34.66 kB / 0.6126 GB, free: 87.69 MB / 362.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 9.965e-05/0.4194, allocations: 50.34 kB / 0.6127 GB, free: 87.69 MB / 362.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00183/0.4212, allocations: 0.6627 MB / 0.6133 GB, free: 87.61 MB / 362.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.462e-05/0.4213, allocations: 4.453 kB / 0.6133 GB, free: 87.61 MB / 362.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.181e-05/0.4214, allocations: 20.53 kB / 0.6134 GB, free: 87.61 MB / 362.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.845e-05/0.4214, allocations: 23.91 kB / 0.6134 GB, free: 87.61 MB / 362.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001755/0.4232, allocations: 0.4989 MB / 0.6139 GB, free: 87.6 MB / 362.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.003314/0.4266, allocations: 1.503 MB / 0.6153 GB, free: 86.95 MB / 362.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.00104/0.4277, allocations: 306.4 kB / 0.6156 GB, free: 86.88 MB / 362.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006199/0.4283, allocations: 162.4 kB / 0.6158 GB, free: 86.85 MB / 362.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 8.484e-05/0.4284, allocations: 18.36 kB / 0.6158 GB, free: 86.85 MB / 362.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.633e-05/0.4285, allocations: 39.97 kB / 0.6158 GB, free: 86.8 MB / 362.7 MB
Notification: Performance of pre-optimization done (n=20): time 3.476e-06/0.4285, allocations: 3.031 kB / 0.6158 GB, free: 86.8 MB / 362.7 MB
Notification: Performance of matching and sorting (n=20): time 0.002304/0.4308, allocations: 0.5231 MB / 0.6163 GB, free: 86.74 MB / 362.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.501e-05/0.4309, allocations: 105 kB / 0.6164 GB, free: 86.62 MB / 362.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.00103/0.4319, allocations: 0.5426 MB / 0.617 GB, free: 86.5 MB / 362.7 MB
Notification: Performance of collectPreVariables (initialization): time 8.341e-05/0.432, allocations: 26.83 kB / 0.617 GB, free: 86.47 MB / 362.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002141/0.4323, allocations: 231.4 kB / 0.6172 GB, free: 86.35 MB / 362.7 MB
Notification: Performance of collectInitialBindings (initialization): time 9.898e-05/0.4324, allocations: 69.5 kB / 0.6173 GB, free: 86.31 MB / 362.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.559e-05/0.4324, allocations: 5.281 kB / 0.6173 GB, free: 86.31 MB / 362.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001177/0.4325, allocations: 362.9 kB / 0.6176 GB, free: 85.99 MB / 362.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0007054/0.4333, allocations: 169.2 kB / 0.6178 GB, free: 85.99 MB / 362.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007442/0.434, allocations: 292.2 kB / 0.6181 GB, free: 85.84 MB / 362.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007621/0.4348, allocations: 204.4 kB / 0.6183 GB, free: 85.84 MB / 362.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 7.694e-06/0.4348, allocations: 1.188 kB / 0.6183 GB, free: 85.84 MB / 362.7 MB
Notification: Performance of matching and sorting (n=36) (initialization): time 0.001863/0.4367, allocations: 0.515 MB / 0.6188 GB, free: 85.76 MB / 362.7 MB
Notification: Performance of prepare postOptimizeDAE: time 2.966e-05/0.4368, allocations: 7.219 kB / 0.6188 GB, free: 85.76 MB / 362.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001235/0.4369, allocations: 43.47 kB / 0.6188 GB, free: 85.76 MB / 362.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.863e-05/0.437, allocations: 6.688 kB / 0.6188 GB, free: 85.76 MB / 362.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004094/0.4374, allocations: 47.7 kB / 0.6189 GB, free: 85.76 MB / 362.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.683e-05/0.4374, allocations: 7.969 kB / 0.6189 GB, free: 85.76 MB / 362.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0006847/0.4381, allocations: 84.77 kB / 0.619 GB, free: 85.72 MB / 362.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.526e-05/0.4382, allocations: 19.8 kB / 0.619 GB, free: 85.72 MB / 362.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 18
 * Number of states: 0 ()
 * Number of discrete variables: 12 (m_flow_IN_con_4[3].target,m_flow_IN_con_4[2].target,m_flow_IN_con_4[1].target,m_flow_IN_con_3[3].target,m_flow_IN_con_3[2].target,m_flow_IN_con_3[1].target,m_flow_IN_con_2[3].target,m_flow_IN_con_2[2].target,m_flow_IN_con_2[1].target,m_flow_IN_con_1[3].target,m_flow_IN_con_1[2].target,m_flow_IN_con_1[1].target)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (33):
 * Single equations (assignments): 21
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 12
 * 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.0004257/0.4386, allocations: 220.6 kB / 0.6192 GB, free: 85.59 MB / 362.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001654/0.4388, allocations: 42.03 kB / 0.6192 GB, free: 85.57 MB / 362.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001537/0.4404, allocations: 456.3 kB / 0.6197 GB, free: 85.52 MB / 362.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 1.201e-05/0.4404, allocations: 6.906 kB / 0.6197 GB, free: 85.52 MB / 362.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 0.0001143/0.4405, allocations: 42.05 kB / 0.6197 GB, free: 85.52 MB / 362.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003985/0.4409, allocations: 158.2 kB / 0.6199 GB, free: 85.41 MB / 362.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001315/0.4411, allocations: 5.672 kB / 0.6199 GB, free: 85.41 MB / 362.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005509/0.4416, allocations: 23.61 kB / 0.6199 GB, free: 85.41 MB / 362.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00013/0.4418, allocations: 29.28 kB / 0.6199 GB, free: 85.4 MB / 362.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001644/0.4435, allocations: 0.6135 MB / 0.6205 GB, free: 85.14 MB / 362.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.002676/0.4462, allocations: 0.7022 MB / 0.6212 GB, free: 84.76 MB / 362.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001145/0.4474, allocations: 157.2 kB / 0.6214 GB, free: 84.76 MB / 362.7 MB
Notification: Performance of sorting global known variables: time 0.001482/0.4489, allocations: 397.7 kB / 0.6217 GB, free: 84.67 MB / 362.7 MB
Notification: Performance of Backend: time 1.683e-06/0.449, allocations: 0 / 0.6217 GB, free: 84.67 MB / 362.7 MB
Notification: Performance of simCode: created initialization part: time 0.004218/0.4532, allocations: 0.6766 MB / 0.6224 GB, free: 84.21 MB / 362.7 MB
Notification: Performance of SimCode: time 0.0043/0.4576, allocations: 1.662 MB / 0.624 GB, free: 82.98 MB / 362.7 MB
Notification: Performance of Templates: time 0.02518/0.4829, allocations: 8.266 MB / 0.6321 GB, free: 80.91 MB / 362.7 MB
"Warning: Resultfile and Reference have different end time points!
Reffile[5004]=1.010000
File[8917]=1.800022
"

Variables in the reference:time,cp[1],cp[2],cp[3],eta[1],eta[2],eta[3],lambda[1],lambda[2],lambda[3],rho[1],rho[2],rho[3],m_flow[1],m_flow[2],m_flow[3],Re_1[1],Re_1[2],Re_1[3],Nu_1[1],Nu_1[2],Nu_1[3],Nu_2[1],Nu_2[2],Nu_2[3],Nu_3[1],Nu_3[2],Nu_3[3],Nu_4[1],Nu_4[2],Nu_4[3],Re,Pr[1],Pr[2],Pr[3],input_mflow_0.y,input_mflow_1.y,input_mflow_2.y

Variables in the result:L,Nu_1[1],Nu_1[2],Nu_1[3],Nu_2[1],Nu_2[2],Nu_2[3],Nu_3[1],Nu_3[2],Nu_3[3],Nu_4[1],Nu_4[2],Nu_4[3],Pr[1],Pr[2],Pr[3],Re,Re_1[1],Re_1[2],Re_1[3],cp[1],cp[2],cp[3],d_hyd,eta[1],eta[2],eta[3],frac_dtoL,input_mflow_0.duration,input_mflow_0.height,input_mflow_0.offset,input_mflow_0.startTime,input_mflow_0.y,input_mflow_1.amplitude,input_mflow_1.freqHz,input_mflow_1.offset,input_mflow_1.phase,input_mflow_1.startTime,input_mflow_1.y,input_mflow_2.fallTimeConst,input_mflow_2.offset,input_mflow_2.outMax,input_mflow_2.riseTime,input_mflow_2.riseTimeConst,input_mflow_2.startTime,input_mflow_2.y,lambda[1],lambda[2],lambda[3],m_flow[1],m_flow[2],m_flow[3],m_flow_IN_con_1[1].L,m_flow_IN_con_1[1].d_hyd,m_flow_IN_con_1[2].L,m_flow_IN_con_1[2].d_hyd,m_flow_IN_con_1[3].L,m_flow_IN_con_1[3].d_hyd,m_flow_IN_con_2[1].L,m_flow_IN_con_2[1].d_hyd,m_flow_IN_con_2[2].L,m_flow_IN_con_2[2].d_hyd,m_flow_IN_con_2[3].L,m_flow_IN_con_2[3].d_hyd,m_flow_IN_con_3[1].L,m_flow_IN_con_3[1].d_hyd,m_flow_IN_con_3[2].L,m_flow_IN_con_3[2].d_hyd,m_flow_IN_con_3[3].L,m_flow_IN_con_3[3].d_hyd,m_flow_IN_con_4[1].L,m_flow_IN_con_4[1].d_hyd,m_flow_IN_con_4[2].L,m_flow_IN_con_4[2].d_hyd,m_flow_IN_con_4[3].L,m_flow_IN_con_4[3].d_hyd,m_flow_IN_var_1[1].cp,m_flow_IN_var_1[1].eta,m_flow_IN_var_1[1].lambda,m_flow_IN_var_1[1].rho,m_flow_IN_var_1[2].cp,m_flow_IN_var_1[2].eta,m_flow_IN_var_1[2].lambda,m_flow_IN_var_1[2].rho,m_flow_IN_var_1[3].cp,m_flow_IN_var_1[3].eta,m_flow_IN_var_1[3].lambda,m_flow_IN_var_1[3].rho,m_flow_IN_var_2[1].cp,m_flow_IN_var_2[1].eta,m_flow_IN_var_2[1].lambda,m_flow_IN_var_2[1].rho,m_flow_IN_var_2[2].cp,m_flow_IN_var_2[2].eta,m_flow_IN_var_2[2].lambda,m_flow_IN_var_2[2].rho,m_flow_IN_var_2[3].cp,m_flow_IN_var_2[3].eta,m_flow_IN_var_2[3].lambda,m_flow_IN_var_2[3].rho,m_flow_IN_var_3[1].cp,m_flow_IN_var_3[1].eta,m_flow_IN_var_3[1].lambda,m_flow_IN_var_3[1].rho,m_flow_IN_var_3[2].cp,m_flow_IN_var_3[2].eta,m_flow_IN_var_3[2].lambda,m_flow_IN_var_3[2].rho,m_flow_IN_var_3[3].cp,m_flow_IN_var_3[3].eta,m_flow_IN_var_3[3].lambda,m_flow_IN_var_3[3].rho,m_flow_IN_var_4[1].cp,m_flow_IN_var_4[1].eta,m_flow_IN_var_4[1].lambda,m_flow_IN_var_4[1].rho,m_flow_IN_var_4[2].cp,m_flow_IN_var_4[2].eta,m_flow_IN_var_4[2].lambda,m_flow_IN_var_4[2].rho,m_flow_IN_var_4[3].cp,m_flow_IN_var_4[3].eta,m_flow_IN_var_4[3].lambda,m_flow_IN_var_4[3].rho,n,rho[1],rho[2],rho[3],time