Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.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.001216/0.001216, allocations: 100.4 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.001429/0.001429, allocations: 210.1 kB / 23.01 MB, free: 4.93 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.355/1.355, allocations: 230.6 MB / 256.8 MB, free: 7.816 MB / 206.1 MB
"
[Timeout remaining time 178]
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.889/2.889, allocations: 0.49 GB / 0.7958 GB, free: 35.39 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.SeriesDpOptimised,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|sin.ports.1..m_flow",fileNamePrefix="Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised")
translateModel(Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|sin.ports.1..m_flow",fileNamePrefix="Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised") [Timeout 300]
"Notification: Performance of FrontEnd - Absyn->SCode: time 1.747e-05/1.747e-05, allocations: 3.25 kB / 1.155 GB, free: 25.26 MB / 0.9044 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised): time 0.1741/0.1741, allocations: 142.4 MB / 1.294 GB, free: 2.477 MB / 0.9825 GB
Notification: Performance of NFInst.instExpressions: time 0.004856/0.1789, allocations: 3.342 MB / 1.297 GB, free: 15.12 MB / 0.9981 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0002775/0.1792, allocations: 19.81 kB / 1.297 GB, free: 15.11 MB / 0.9981 GB
Notification: Performance of NFTyping.typeComponents: time 0.0005562/0.1798, allocations: 162.9 kB / 1.298 GB, free: 14.95 MB / 0.9981 GB
Notification: Performance of NFTyping.typeBindings: time 0.00132/0.1811, allocations: 0.5406 MB / 1.298 GB, free: 14.4 MB / 0.9981 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001134/0.1822, allocations: 453.2 kB / 1.299 GB, free: 13.96 MB / 0.9981 GB
Notification: Performance of NFFlatten.flatten: time 0.001589/0.1838, allocations: 1.468 MB / 1.3 GB, free: 12.49 MB / 0.9981 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009619/0.1848, allocations: 0.6979 MB / 1.301 GB, free: 11.79 MB / 0.9981 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001534/0.1863, allocations: 0.8805 MB / 1.301 GB, free: 10.91 MB / 0.9981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.0004382/0.1868, allocations: 383 kB / 1.302 GB, free: 10.53 MB / 0.9981 GB
Notification: Performance of NFPackage.collectConstants: time 7.057e-05/0.1868, allocations: 32 kB / 1.302 GB, free: 10.5 MB / 0.9981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.0009345/0.1878, allocations: 0.5807 MB / 1.302 GB, free: 9.918 MB / 0.9981 GB
Notification: Performance of combineBinaries: time 0.0007947/0.1886, allocations: 0.8225 MB / 1.303 GB, free: 9.09 MB / 0.9981 GB
Notification: Performance of replaceArrayConstructors: time 0.0003686/0.1889, allocations: 499.3 kB / 1.304 GB, free: 8.598 MB / 0.9981 GB
Notification: Performance of NFVerifyModel.verify: time 7.569e-05/0.189, allocations: 32 kB / 1.304 GB, free: 8.566 MB / 0.9981 GB
Notification: Performance of FrontEnd: time 4.657e-05/0.189, allocations: 8 kB / 1.304 GB, free: 8.559 MB / 0.9981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 125 (87)
 * Number of variables: 125 (33)
Notification: Performance of [SIM] Bindings: time 0.002644/0.1917, allocations: 2.444 MB / 1.306 GB, free: 5.977 MB / 0.9981 GB
Notification: Performance of [SIM] FunctionAlias: time 0.0002138/0.1919, allocations: 207.7 kB / 1.306 GB, free: 5.762 MB / 0.9981 GB
Notification: Performance of [SIM] Early Inline: time 0.001229/0.1931, allocations: 1.225 MB / 1.308 GB, free: 4.508 MB / 0.9981 GB
Notification: Performance of [SIM] Simplify 1: time 0.000346/0.1935, allocations: 245.6 kB / 1.308 GB, free: 4.219 MB / 0.9981 GB
Notification: Performance of [SIM] Alias: time 0.001219/0.1947, allocations: 0.8807 MB / 1.309 GB, free: 3.219 MB / 0.9981 GB
Notification: Performance of [SIM] Simplify 2: time 0.0003044/0.195, allocations: 237.4 kB / 1.309 GB, free: 2.938 MB / 0.9981 GB
Notification: Performance of [SIM] Remove Stream: time 0.0001874/0.1952, allocations: 160.1 kB / 1.309 GB, free: 2.754 MB / 0.9981 GB
Notification: Performance of [SIM] Detect States: time 0.0003632/0.1956, allocations: 304.5 kB / 1.309 GB, free: 2.402 MB / 0.9981 GB
Notification: Performance of [SIM] Events: time 0.0001241/0.1957, allocations: 80.14 kB / 1.309 GB, free: 2.324 MB / 0.9981 GB
Notification: Performance of [SIM] Partitioning: time 0.0005284/0.1962, allocations: 495.6 kB / 1.31 GB, free: 1.785 MB / 0.9981 GB
Notification: Performance of [SIM] Causalize: time 0.001613/0.1978, allocations: 1.285 MB / 1.311 GB, free: 456 kB / 0.9981 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.0008412/0.1987, allocations: 0.9094 MB / 1.312 GB, free: 15.54 MB / 1.014 GB
Notification: Performance of [INI] Simplify: time 0.001135/0.1998, allocations: 0.6842 MB / 1.313 GB, free: 14.79 MB / 1.014 GB
Notification: Performance of [INI] Inline: time 0.001438/0.2012, allocations: 1.565 MB / 1.314 GB, free: 13.21 MB / 1.014 GB
Notification: Performance of [INI] Partitioning: time 5.343e-05/0.2013, allocations: 33.3 kB / 1.314 GB, free: 13.18 MB / 1.014 GB
Notification: Performance of [INI] Cleanup: time 0.0003111/0.2016, allocations: 323.7 kB / 1.315 GB, free: 12.86 MB / 1.014 GB
Notification: Performance of [INI] Causalize: time 0.004894/0.2065, allocations: 3.794 MB / 1.318 GB, free: 9.023 MB / 1.014 GB
Notification: Performance of [INI] Tearing: time 0.0003268/0.2068, allocations: 282.4 kB / 1.319 GB, free: 8.75 MB / 1.014 GB
Notification: Performance of [SIM] Initialization: time 1.133e-06/0.2068, allocations: 0 / 1.319 GB, free: 8.75 MB / 1.014 GB
Notification: Performance of [SIM] Remove Dummies: time 9.638e-06/0.2068, allocations: 0 / 1.319 GB, free: 8.75 MB / 1.014 GB
Notification: Performance of [SIM] Tearing: time 0.0001278/0.207, allocations: 125.5 kB / 1.319 GB, free: 8.629 MB / 1.014 GB
Notification: Performance of [SIM] Categorize: time 1.603e-05/0.207, allocations: 4 kB / 1.319 GB, free: 8.625 MB / 1.014 GB
Notification: Performance of [SIM] Solve: time 0.001205/0.2082, allocations: 0.7328 MB / 1.319 GB, free: 7.945 MB / 1.014 GB
Notification: Performance of [SIM] Jacobian: time 0.001186/0.2094, allocations: 0.9658 MB / 1.32 GB, free: 6.934 MB / 1.014 GB
Notification: Partition statistics after passing the back-end:
 * Number of ODE partitions: ..................... 0
 * Number of algebraic partitions: ............... 6
 * 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_p.T_start, pulse_p.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: ........... 59 (scalar:57, 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: ........... 68 (scalar:62, 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: ........... 68 (scalar:62, 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 5.853e-05/0.2094, allocations: 40.61 kB / 1.32 GB, free: 6.898 MB / 1.014 GB
Notification: Performance of SimCode: time 0.006832/0.2163, allocations: 6.044 MB / 1.326 GB, free: 0.7812 MB / 1.014 GB
Notification: Performance of Templates: time 0.02205/0.2383, allocations: 14.43 MB / 1.34 GB, free: 2.508 MB / 1.029 GB
"
[Timeout remaining time 300]
make -j1 -f Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.pipe ; mkfifo Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.pipe ; head -c 1048576 < Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.pipe >> ../files/Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.sim & ./Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_Fluid_Examples_Performance_PressureDrop_SeriesDpOptimised.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.Fluid.Examples.Performance.PressureDrop.SeriesDpOptimised.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_p.amplitude,pulse_p.nperiod,pulse_p.offset,pulse_p.period,pulse_p.startTime,pulse_p.width,resSeries[10]._dp_start,resSeries[10]._m_flow_start,resSeries[10].allowFlowReversal,resSeries[10].coeff,resSeries[10].computeFlowResistance,resSeries[10].deltaM,resSeries[10].disableComputeFlowResistance_internal,resSeries[10].dp_nominal,resSeries[10].dp_nominal_pos,resSeries[10].eta_default,resSeries[10].from_dp,resSeries[10].k,resSeries[10].linearized,resSeries[10].m_flow_nominal,resSeries[10].m_flow_nominal_pos,resSeries[10].m_flow_small,resSeries[10].m_flow_turbulent,resSeries[10].sta_default.T,resSeries[10].sta_default.X[1],resSeries[10].sta_default.X[2],resSeries[10].sta_default.p,resSeries[1]._dp_start,resSeries[1]._m_flow_start,resSeries[1].allowFlowReversal,resSeries[1].coeff,resSeries[1].computeFlowResistance,resSeries[1].deltaM,resSeries[1].disableComputeFlowResistance_internal,resSeries[1].dp_nominal,resSeries[1].dp_nominal_pos,resSeries[1].eta_default,resSeries[1].from_dp,resSeries[1].k,resSeries[1].linearized,resSeries[1].m_flow_nominal,resSeries[1].m_flow_nominal_pos,resSeries[1].m_flow_small,resSeries[1].m_flow_turbulent,resSeries[1].sta_default.T,resSeries[1].sta_default.X[1],resSeries[1].sta_default.X[2],resSeries[1].sta_default.p,resSeries[2]._dp_start,resSeries[2]._m_flow_start,resSeries[2].allowFlowReversal,resSeries[2].coeff,resSeries[2].computeFlowResistance,resSeries[2].deltaM,resSeries[2].disableComputeFlowResistance_internal,resSeries[2].dp_nominal,resSeries[2].dp_nominal_pos,resSeries[2].eta_default,resSeries[2].from_dp,resSeries[2].k,resSeries[2].linearized,resSeries[2].m_flow_nominal,resSeries[2].m_flow_nominal_pos,resSeries[2].m_flow_small,resSeries[2].m_flow_turbulent,resSeries[2].sta_default.T,resSeries[2].sta_default.X[1],resSeries[2].sta_default.X[2],resSeries[2].sta_default.p,resSeries[3]._dp_start,resSeries[3]._m_flow_start,resSeries[3].allowFlowReversal,resSeries[3].coeff,resSeries[3].computeFlowResistance,resSeries[3].deltaM,resSeries[3].disableComputeFlowResistance_internal,resSeries[3].dp_nominal,resSeries[3].dp_nominal_pos,resSeries[3].eta_default,resSeries[3].from_dp,resSeries[3].k,resSeries[3].linearized,resSeries[3].m_flow_nominal,resSeries[3].m_flow_nominal_pos,resSeries[3].m_flow_small,resSeries[3].m_flow_turbulent,resSeries[3].sta_default.T,resSeries[3].sta_default.X[1],resSeries[3].sta_default.X[2],resSeries[3].sta_default.p,resSeries[4]._dp_start,resSeries[4]._m_flow_start,resSeries[4].allowFlowReversal,resSeries[4].coeff,resSeries[4].computeFlowResistance,resSeries[4].deltaM,resSeries[4].disableComputeFlowResistance_internal,resSeries[4].dp_nominal,resSeries[4].dp_nominal_pos,resSeries[4].eta_default,resSeries[4].from_dp,resSeries[4].k,resSeries[4].linearized,resSeries[4].m_flow_nominal,resSeries[4].m_flow_nominal_pos,resSeries[4].m_flow_small,resSeries[4].m_flow_turbulent,resSeries[4].sta_default.T,resSeries[4].sta_default.X[1],resSeries[4].sta_default.X[2],resSeries[4].sta_default.p,resSeries[5]._dp_start,resSeries[5]._m_flow_start,resSeries[5].allowFlowReversal,resSeries[5].coeff,resSeries[5].computeFlowResistance,resSeries[5].deltaM,resSeries[5].disableComputeFlowResistance_internal,resSeries[5].dp_nominal,resSeries[5].dp_nominal_pos,resSeries[5].eta_default,resSeries[5].from_dp,resSeries[5].k,resSeries[5].linearized,resSeries[5].m_flow_nominal,resSeries[5].m_flow_nominal_pos,resSeries[5].m_flow_small,resSeries[5].m_flow_turbulent,resSeries[5].sta_default.T,resSeries[5].sta_default.X[1],resSeries[5].sta_default.X[2],resSeries[5].sta_default.p,resSeries[6]._dp_start,resSeries[6]._m_flow_start,resSeries[6].allowFlowReversal,resSeries[6].coeff,resSeries[6].computeFlowResistance,resSeries[6].deltaM,resSeries[6].disableComputeFlowResistance_internal,resSeries[6].dp_nominal,resSeries[6].dp_nominal_pos,resSeries[6].eta_default,resSeries[6].from_dp,resSeries[6].k,resSeries[6].linearized,resSeries[6].m_flow_nominal,resSeries[6].m_flow_nominal_pos,resSeries[6].m_flow_small,resSeries[6].m_flow_turbulent,resSeries[6].sta_default.T,resSeries[6].sta_default.X[1],resSeries[6].sta_default.X[2],resSeries[6].sta_default.p,resSeries[7]._dp_start,resSeries[7]._m_flow_start,resSeries[7].allowFlowReversal,resSeries[7].coeff,resSeries[7].computeFlowResistance,resSeries[7].deltaM,resSeries[7].disableComputeFlowResistance_internal,resSeries[7].dp_nominal,resSeries[7].dp_nominal_pos,resSeries[7].eta_default,resSeries[7].from_dp,resSeries[7].k,resSeries[7].linearized,resSeries[7].m_flow_nominal,resSeries[7].m_flow_nominal_pos,resSeries[7].m_flow_small,resSeries[7].m_flow_turbulent,resSeries[7].sta_default.T,resSeries[7].sta_default.X[1],resSeries[7].sta_default.X[2],resSeries[7].sta_default.p,resSeries[8]._dp_start,resSeries[8]._m_flow_start,resSeries[8].allowFlowReversal,resSeries[8].coeff,resSeries[8].computeFlowResistance,resSeries[8].deltaM,resSeries[8].disableComputeFlowResistance_internal,resSeries[8].dp_nominal,resSeries[8].dp_nominal_pos,resSeries[8].eta_default,resSeries[8].from_dp,resSeries[8].k,resSeries[8].linearized,resSeries[8].m_flow_nominal,resSeries[8].m_flow_nominal_pos,resSeries[8].m_flow_small,resSeries[8].m_flow_turbulent,resSeries[8].sta_default.T,resSeries[8].sta_default.X[1],resSeries[8].sta_default.X[2],resSeries[8].sta_default.p,resSeries[9]._dp_start,resSeries[9]._m_flow_start,resSeries[9].allowFlowReversal,resSeries[9].coeff,resSeries[9].computeFlowResistance,resSeries[9].deltaM,resSeries[9].disableComputeFlowResistance_internal,resSeries[9].dp_nominal,resSeries[9].dp_nominal_pos,resSeries[9].eta_default,resSeries[9].from_dp,resSeries[9].k,resSeries[9].linearized,resSeries[9].m_flow_nominal,resSeries[9].m_flow_nominal_pos,resSeries[9].m_flow_small,resSeries[9].m_flow_turbulent,resSeries[9].sta_default.T,resSeries[9].sta_default.X[1],resSeries[9].sta_default.X[2],resSeries[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.369524815119803]