Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001171/0.001171, allocations: 104.3 kB / 19.72 MB, free: 2.121 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.001273/0.001273, allocations: 218.5 kB / 23.01 MB, free: 4.922 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.316/1.316, allocations: 230.6 MB / 256.8 MB, free: 7.809 MB / 206.1 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo): time 2.877/2.877, allocations: 0.49 GB / 0.7958 GB, free: 35.31 MB / 0.6231 GB
"
[Timeout remaining time 177]
Using package Buildings with version 12.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.1.1-maint.12.x/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|sin.ports.1..m_flow",fileNamePrefix="Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised")
translateModel(Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|sin.ports.1..m_flow",fileNamePrefix="Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.834e-05/1.834e-05, allocations: 2.281 kB / 1.155 GB, free: 25.25 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised): time 0.1812/0.1812, allocations: 148 MB / 1.3 GB, free: 12.92 MB / 0.9981 GB
Notification: Performance of NFInst.instExpressions: time 0.005858/0.187, allocations: 3.766 MB / 1.303 GB, free: 9.148 MB / 0.9981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0004749/0.1875, allocations: 27.75 kB / 1.303 GB, free: 9.121 MB / 0.9981 GB
Notification: Performance of NFTyping.typeComponents: time 0.0008534/0.1884, allocations: 230.5 kB / 1.303 GB, free: 8.895 MB / 0.9981 GB
Notification: Performance of NFTyping.typeBindings: time 0.002076/0.1904, allocations: 0.6962 MB / 1.304 GB, free: 8.195 MB / 0.9981 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001411/0.1919, allocations: 493.8 kB / 1.305 GB, free: 7.719 MB / 0.9981 GB
Notification: Performance of NFFlatten.flatten: time 0.002284/0.1941, allocations: 1.764 MB / 1.306 GB, free: 5.945 MB / 0.9981 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.004958/0.1991, allocations: 4.051 MB / 1.31 GB, free: 1.887 MB / 0.9981 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002861/0.202, allocations: 1.602 MB / 1.312 GB, free: 288 kB / 0.9981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001666/0.2036, allocations: 1.396 MB / 1.313 GB, free: 14.88 MB / 1.014 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003042/0.2039, allocations: 164 kB / 1.313 GB, free: 14.72 MB / 1.014 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.001345/0.2053, allocations: 0.7523 MB / 1.314 GB, free: 13.97 MB / 1.014 GB
Notification: Performance of combineBinaries: time 0.001915/0.2072, allocations: 1.983 MB / 1.316 GB, free: 11.98 MB / 1.014 GB
Notification: Performance of replaceArrayConstructors: time 0.0005024/0.2077, allocations: 0.6188 MB / 1.317 GB, free: 11.35 MB / 1.014 GB
Notification: Performance of NFVerifyModel.verify: time 0.0001498/0.2078, allocations: 44 kB / 1.317 GB, free: 11.31 MB / 1.014 GB
Notification: Performance of FrontEnd: time 6.843e-05/0.2079, allocations: 15.94 kB / 1.317 GB, free: 11.29 MB / 1.014 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 135 (97)
 * Number of variables: 135 (43)
Notification: Performance of [SIM] Bindings: time 0.004999/0.2129, allocations: 5.024 MB / 1.322 GB, free: 6.121 MB / 1.014 GB
Notification: Performance of [SIM] FunctionAlias: time 0.001964/0.2149, allocations: 1.865 MB / 1.323 GB, free: 4.238 MB / 1.014 GB
Notification: Performance of [SIM] Early Inline: time 0.006361/0.2212, allocations: 6.291 MB / 1.33 GB, free: 13.91 MB / 1.029 GB
Notification: Performance of [SIM] Simplify 1: time 0.002759/0.224, allocations: 1.879 MB / 1.331 GB, free: 11.98 MB / 1.029 GB
Notification: Performance of [SIM] Alias: time 0.004053/0.228, allocations: 3.257 MB / 1.335 GB, free: 8.598 MB / 1.029 GB
Notification: Performance of [SIM] Simplify 2: time 0.0032/0.2312, allocations: 1.87 MB / 1.336 GB, free: 6.676 MB / 1.029 GB
Notification: Performance of [SIM] Remove Stream: time 0.004126/0.2354, allocations: 2.536 MB / 1.339 GB, free: 4.109 MB / 1.029 GB
Notification: Performance of [SIM] Detect States: time 0.001957/0.2373, allocations: 1.29 MB / 1.34 GB, free: 2.766 MB / 1.029 GB
Notification: Performance of [SIM] Events: time 0.0005451/0.2379, allocations: 356.7 kB / 1.341 GB, free: 2.414 MB / 1.029 GB
Notification: Performance of [SIM] Partitioning: time 0.00246/0.2403, allocations: 2.26 MB / 1.343 GB, free: 136 kB / 1.029 GB
Notification: Performance of [SIM] Causalize: time 0.007194/0.2475, allocations: 4.928 MB / 1.348 GB, free: 11.14 MB / 1.045 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.004968/0.2525, allocations: 5.164 MB / 1.353 GB, free: 5.977 MB / 1.045 GB
Notification: Performance of [INI] Simplify: time 0.003816/0.2563, allocations: 2.605 MB / 1.355 GB, free: 3.301 MB / 1.045 GB
Notification: Performance of [INI] Inline: time 0.008547/0.2649, allocations: 8.925 MB / 1.364 GB, free: 10.36 MB / 1.061 GB
Notification: Performance of [INI] Partitioning: time 9.048e-05/0.265, allocations: 33.38 kB / 1.364 GB, free: 10.32 MB / 1.061 GB
Notification: Performance of [INI] Cleanup: time 0.002243/0.2672, allocations: 1.635 MB / 1.365 GB, free: 8.684 MB / 1.061 GB
Notification: Performance of [INI] Causalize: time 0.01678/0.284, allocations: 11.49 MB / 1.377 GB, free: 13.12 MB / 1.076 GB
Notification: Performance of [INI] Tearing: time 0.000435/0.2844, allocations: 298.2 kB / 1.377 GB, free: 12.83 MB / 1.076 GB
Notification: Performance of [SIM] Initialization: time 2.044e-06/0.2844, allocations: 1.969 kB / 1.377 GB, free: 12.83 MB / 1.076 GB
Notification: Performance of [SIM] Remove Dummies: time 2.016e-05/0.2844, allocations: 0.6562 kB / 1.377 GB, free: 12.83 MB / 1.076 GB
Notification: Performance of [SIM] Tearing: time 0.0001512/0.2846, allocations: 135.8 kB / 1.377 GB, free: 12.7 MB / 1.076 GB
Notification: Performance of [SIM] Categorize: time 1.837e-05/0.2846, allocations: 4 kB / 1.377 GB, free: 12.69 MB / 1.076 GB
Notification: Performance of [SIM] Solve: time 0.007695/0.2923, allocations: 5.596 MB / 1.383 GB, free: 7.145 MB / 1.076 GB
Notification: Performance of [SIM] Jacobian: time 0.001237/0.2935, allocations: 0.8914 MB / 1.383 GB, free: 6.211 MB / 1.076 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 2
 * Number of ODE event partitions: ............... 0
 * Number of algebraic event partitions: ......... 1
 * Number of clocked partitions: ................. 0
 * Number of initial partitions: ................. 1
 * Number of initial(lambda=0) partitions: ....... 1
Notification: Variable statistics after passing the back-end:
 * Number of states: ............................. 0 (0) {}
 * Number of discrete states: .................... 2 (2) {pulse_m_flow.T_start, pulse_m_flow.count}
 * Number of clocked states: ..................... 0 (0) {}
 * Number of discrete variables: ................. 4 (4) {$SEV_3, $SEV_2, $SEV_1, $SEV_0}
 * Number of clocks: ............................. 0 (0) {}
 * Number of top-level inputs: ................... 0 (0) {}
Notification: [Simulation] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 71 (scalar:69, array:2, record:0)
 * Number of multi strong components: ............ 2 (algorithm:0, when:2, if:0, tuple:0)
 * Number of for-loop strong components: ......... 0 (resizable: 0, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 85 (scalar:79, array:6, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 8 (resizable: 8, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: [Initialization (lambda=0)] Strong Component statistics after passing the back-end:
 * Number of single strong components: ........... 85 (scalar:79, array:6, record:0)
 * Number of multi strong components: ............ 1 (algorithm:1, when:0, if:0, tuple:0)
 * Number of for-loop strong components: ......... 8 (resizable: 8, generic: 0, entwined:0)
 * Number of algebraic-loop strong components: ... 1 (linear: 1, nonlinear:0)
Notification: Performance of backend: time 9.835e-05/0.2936, allocations: 63.03 kB / 1.383 GB, free: 6.156 MB / 1.076 GB
Notification: Performance of SimCode: time 0.00908/0.3027, allocations: 7.012 MB / 1.39 GB, free: 15.07 MB / 1.092 GB
Notification: Performance of Templates: time 0.03753/0.3402, allocations: 26.34 MB / 1.416 GB, free: 4.617 MB / 1.107 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.pipe ; mkfifo Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.pipe >> ../files/Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.sim & ./Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Fluid_Examples_Performance_PressureDrop_SeriesParallelDpOptimised.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesParallelDpOptimised.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
""

Variables in the reference:time,sin.ports[1].m_flow

Variables in the result:dp_nominal,m_flow_nominal,nRes,pulse_m_flow.amplitude,pulse_m_flow.nperiod,pulse_m_flow.offset,pulse_m_flow.period,pulse_m_flow.startTime,pulse_m_flow.width,res2._dp_start,res2._m_flow_start,res2.allowFlowReversal,res2.coeff,res2.computeFlowResistance,res2.deltaM,res2.disableComputeFlowResistance_internal,res2.dp_nominal,res2.dp_nominal_pos,res2.eta_default,res2.from_dp,res2.k,res2.linearized,res2.m_flow_nominal,res2.m_flow_nominal_pos,res2.m_flow_small,res2.m_flow_turbulent,res2.sta_default.T,res2.sta_default.X[1],res2.sta_default.X[2],res2.sta_default.p,resParallel[10]._dp_start,resParallel[10]._m_flow_start,resParallel[10].allowFlowReversal,resParallel[10].coeff,resParallel[10].computeFlowResistance,resParallel[10].deltaM,resParallel[10].disableComputeFlowResistance_internal,resParallel[10].dp_nominal,resParallel[10].dp_nominal_pos,resParallel[10].eta_default,resParallel[10].from_dp,resParallel[10].k,resParallel[10].linearized,resParallel[10].m_flow_nominal,resParallel[10].m_flow_nominal_pos,resParallel[10].m_flow_small,resParallel[10].m_flow_turbulent,resParallel[10].sta_default.T,resParallel[10].sta_default.X[1],resParallel[10].sta_default.X[2],resParallel[10].sta_default.p,resParallel[1]._dp_start,resParallel[1]._m_flow_start,resParallel[1].allowFlowReversal,resParallel[1].coeff,resParallel[1].computeFlowResistance,resParallel[1].deltaM,resParallel[1].disableComputeFlowResistance_internal,resParallel[1].dp_nominal,resParallel[1].dp_nominal_pos,resParallel[1].eta_default,resParallel[1].from_dp,resParallel[1].k,resParallel[1].linearized,resParallel[1].m_flow_nominal,resParallel[1].m_flow_nominal_pos,resParallel[1].m_flow_small,resParallel[1].m_flow_turbulent,resParallel[1].sta_default.T,resParallel[1].sta_default.X[1],resParallel[1].sta_default.X[2],resParallel[1].sta_default.p,resParallel[2]._dp_start,resParallel[2]._m_flow_start,resParallel[2].allowFlowReversal,resParallel[2].coeff,resParallel[2].computeFlowResistance,resParallel[2].deltaM,resParallel[2].disableComputeFlowResistance_internal,resParallel[2].dp_nominal,resParallel[2].dp_nominal_pos,resParallel[2].eta_default,resParallel[2].from_dp,resParallel[2].k,resParallel[2].linearized,resParallel[2].m_flow_nominal,resParallel[2].m_flow_nominal_pos,resParallel[2].m_flow_small,resParallel[2].m_flow_turbulent,resParallel[2].sta_default.T,resParallel[2].sta_default.X[1],resParallel[2].sta_default.X[2],resParallel[2].sta_default.p,resParallel[3]._dp_start,resParallel[3]._m_flow_start,resParallel[3].allowFlowReversal,resParallel[3].coeff,resParallel[3].computeFlowResistance,resParallel[3].deltaM,resParallel[3].disableComputeFlowResistance_internal,resParallel[3].dp_nominal,resParallel[3].dp_nominal_pos,resParallel[3].eta_default,resParallel[3].from_dp,resParallel[3].k,resParallel[3].linearized,resParallel[3].m_flow_nominal,resParallel[3].m_flow_nominal_pos,resParallel[3].m_flow_small,resParallel[3].m_flow_turbulent,resParallel[3].sta_default.T,resParallel[3].sta_default.X[1],resParallel[3].sta_default.X[2],resParallel[3].sta_default.p,resParallel[4]._dp_start,resParallel[4]._m_flow_start,resParallel[4].allowFlowReversal,resParallel[4].coeff,resParallel[4].computeFlowResistance,resParallel[4].deltaM,resParallel[4].disableComputeFlowResistance_internal,resParallel[4].dp_nominal,resParallel[4].dp_nominal_pos,resParallel[4].eta_default,resParallel[4].from_dp,resParallel[4].k,resParallel[4].linearized,resParallel[4].m_flow_nominal,resParallel[4].m_flow_nominal_pos,resParallel[4].m_flow_small,resParallel[4].m_flow_turbulent,resParallel[4].sta_default.T,resParallel[4].sta_default.X[1],resParallel[4].sta_default.X[2],resParallel[4].sta_default.p,resParallel[5]._dp_start,resParallel[5]._m_flow_start,resParallel[5].allowFlowReversal,resParallel[5].coeff,resParallel[5].computeFlowResistance,resParallel[5].deltaM,resParallel[5].disableComputeFlowResistance_internal,resParallel[5].dp_nominal,resParallel[5].dp_nominal_pos,resParallel[5].eta_default,resParallel[5].from_dp,resParallel[5].k,resParallel[5].linearized,resParallel[5].m_flow_nominal,resParallel[5].m_flow_nominal_pos,resParallel[5].m_flow_small,resParallel[5].m_flow_turbulent,resParallel[5].sta_default.T,resParallel[5].sta_default.X[1],resParallel[5].sta_default.X[2],resParallel[5].sta_default.p,resParallel[6]._dp_start,resParallel[6]._m_flow_start,resParallel[6].allowFlowReversal,resParallel[6].coeff,resParallel[6].computeFlowResistance,resParallel[6].deltaM,resParallel[6].disableComputeFlowResistance_internal,resParallel[6].dp_nominal,resParallel[6].dp_nominal_pos,resParallel[6].eta_default,resParallel[6].from_dp,resParallel[6].k,resParallel[6].linearized,resParallel[6].m_flow_nominal,resParallel[6].m_flow_nominal_pos,resParallel[6].m_flow_small,resParallel[6].m_flow_turbulent,resParallel[6].sta_default.T,resParallel[6].sta_default.X[1],resParallel[6].sta_default.X[2],resParallel[6].sta_default.p,resParallel[7]._dp_start,resParallel[7]._m_flow_start,resParallel[7].allowFlowReversal,resParallel[7].coeff,resParallel[7].computeFlowResistance,resParallel[7].deltaM,resParallel[7].disableComputeFlowResistance_internal,resParallel[7].dp_nominal,resParallel[7].dp_nominal_pos,resParallel[7].eta_default,resParallel[7].from_dp,resParallel[7].k,resParallel[7].linearized,resParallel[7].m_flow_nominal,resParallel[7].m_flow_nominal_pos,resParallel[7].m_flow_small,resParallel[7].m_flow_turbulent,resParallel[7].sta_default.T,resParallel[7].sta_default.X[1],resParallel[7].sta_default.X[2],resParallel[7].sta_default.p,resParallel[8]._dp_start,resParallel[8]._m_flow_start,resParallel[8].allowFlowReversal,resParallel[8].coeff,resParallel[8].computeFlowResistance,resParallel[8].deltaM,resParallel[8].disableComputeFlowResistance_internal,resParallel[8].dp_nominal,resParallel[8].dp_nominal_pos,resParallel[8].eta_default,resParallel[8].from_dp,resParallel[8].k,resParallel[8].linearized,resParallel[8].m_flow_nominal,resParallel[8].m_flow_nominal_pos,resParallel[8].m_flow_small,resParallel[8].m_flow_turbulent,resParallel[8].sta_default.T,resParallel[8].sta_default.X[1],resParallel[8].sta_default.X[2],resParallel[8].sta_default.p,resParallel[9]._dp_start,resParallel[9]._m_flow_start,resParallel[9].allowFlowReversal,resParallel[9].coeff,resParallel[9].computeFlowResistance,resParallel[9].deltaM,resParallel[9].disableComputeFlowResistance_internal,resParallel[9].dp_nominal,resParallel[9].dp_nominal_pos,resParallel[9].eta_default,resParallel[9].from_dp,resParallel[9].k,resParallel[9].linearized,resParallel[9].m_flow_nominal,resParallel[9].m_flow_nominal_pos,resParallel[9].m_flow_small,resParallel[9].m_flow_turbulent,resParallel[9].sta_default.T,resParallel[9].sta_default.X[1],resParallel[9].sta_default.X[2],resParallel[9].sta_default.p,sin.T,sin.T_in_internal,sin.X[1],sin.X[2],sin.X_in_internal[1],sin.X_in_internal[2],sin.Xi_in_internal[1],sin.flowDirection,sin.nPorts,sin.p,sin.p_in_internal,sin.ports[1].m_flow,sin.use_C_in,sin.use_T_in,sin.use_X_in,sin.use_Xi_in,sin.use_p_in,sin.verifyInputs,sou.T,sou.T_in_internal,sou.X[1],sou.X[2],sou.X_in_internal[1],sou.X_in_internal[2],sou.Xi_in_internal[1],sou.flowDirection,sou.nPorts,sou.p,sou.use_C_in,sou.use_T_in,sou.use_X_in,sou.use_Xi_in,sou.use_p_in,sou.verifyInputs,time
[Calling sys.exit(0), Time elapsed: 8.508139143232256]