Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.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.001661/0.001661, allocations: 102.3 kB / 19.7 MB, free: 2.254 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.001867/0.001867, allocations: 217.9 kB / 23.01 MB, free: 4.609 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.494/1.494, allocations: 230.6 MB / 256.8 MB, free: 8.055 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 3.235/3.235, allocations: 0.49 GB / 0.7958 GB, free: 33.46 MB / 0.6231 GB
"
[Timeout remaining time 176]
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.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|bui.Q_flow|bui.vol.m_flow|bui.vol.port_a.h_outflow|bui.vol.port_b.h_outflow|bui.sta_a.p|bui.vol.sta_a.p|bui.vol.sta_b.p",fileNamePrefix="Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS")
translateModel(Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS,tolerance=1e-06,outputFormat="mat",numberOfIntervals=2500,variableFilter="time|bui.Q_flow|bui.vol.m_flow|bui.vol.port_a.h_outflow|bui.vol.port_b.h_outflow|bui.sta_a.p|bui.vol.sta_a.p|bui.vol.sta_b.p",fileNamePrefix="Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS") [Timeout 300]
"Notification: Buildings requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.002035/0.002035, allocations: 65.48 kB / 1.155 GB, free: 25.46 MB / 0.9044 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3725/0.3746, allocations: 176.1 MB / 1.327 GB, free: 1.52 MB / 1.014 GB
Notification: Performance of NFInst.instantiate(Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS): time 0.2325/0.6071, allocations: 194.3 MB / 1.517 GB, free: 14.53 MB / 1.217 GB
Notification: Performance of NFInst.instExpressions: time 0.03847/0.6456, allocations: 26.41 MB / 1.543 GB, free: 4.051 MB / 1.233 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003138/0.6487, allocations: 83.38 kB / 1.543 GB, free: 3.969 MB / 1.233 GB
Notification: Performance of NFTyping.typeComponents: time 0.006561/0.6553, allocations: 2.114 MB / 1.545 GB, free: 1.848 MB / 1.233 GB
Notification: Performance of NFTyping.typeBindings: time 0.01297/0.6682, allocations: 4.57 MB / 1.549 GB, free: 13.27 MB / 1.248 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006868/0.6751, allocations: 2.573 MB / 1.552 GB, free: 10.7 MB / 1.248 GB
Notification: Performance of NFFlatten.flatten: time 0.01259/0.6877, allocations: 7.661 MB / 1.559 GB, free: 3.02 MB / 1.248 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.002748/0.6904, allocations: 1.259 MB / 1.56 GB, free: 1.723 MB / 1.248 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.007106/0.6975, allocations: 2.707 MB / 1.563 GB, free: 15.01 MB / 1.264 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003137/0.7007, allocations: 1.445 MB / 1.565 GB, free: 13.56 MB / 1.264 GB
Notification: Performance of NFPackage.collectConstants: time 0.0005263/0.7012, allocations: 207.9 kB / 1.565 GB, free: 13.36 MB / 1.264 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01099/0.7122, allocations: 4.876 MB / 1.569 GB, free: 8.477 MB / 1.264 GB
Notification: Performance of NFScalarize.scalarize: time 0.001179/0.7134, allocations: 0.6813 MB / 1.57 GB, free: 7.793 MB / 1.264 GB
Notification: Performance of NFVerifyModel.verify: time 0.002173/0.7155, allocations: 1.213 MB / 1.571 GB, free: 6.574 MB / 1.264 GB
Notification: Performance of NFConvertDAE.convert: time 0.01302/0.7286, allocations: 5.776 MB / 1.577 GB, free: 0.7812 MB / 1.264 GB
Notification: Performance of FrontEnd - DAE generated: time 6.873e-06/0.7286, allocations: 0 / 1.577 GB, free: 0.7812 MB / 1.264 GB
Notification: Performance of FrontEnd: time 1.853e-06/0.7286, allocations: 0 / 1.577 GB, free: 0.7812 MB / 1.264 GB
Notification: Performance of Transformations before backend: time 7.431e-05/0.7286, allocations: 0 / 1.577 GB, free: 0.7812 MB / 1.264 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 266
 * Number of variables: 266
Notification: Performance of Generate backend data structure: time 0.007327/0.736, allocations: 2.845 MB / 1.58 GB, free: 13.88 MB / 1.279 GB
Notification: Performance of prepare preOptimizeDAE: time 4.572e-05/0.736, allocations: 12.03 kB / 1.58 GB, free: 13.86 MB / 1.279 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.004573/0.7406, allocations: 0.6541 MB / 1.58 GB, free: 13.21 MB / 1.279 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006143/0.7467, allocations: 2.793 MB / 1.583 GB, free: 10.37 MB / 1.279 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.521e-05/0.7468, allocations: 82.09 kB / 1.583 GB, free: 10.29 MB / 1.279 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002464/0.7471, allocations: 116 kB / 1.583 GB, free: 10.18 MB / 1.279 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002866/0.7499, allocations: 1.335 MB / 1.585 GB, free: 8.754 MB / 1.279 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.388e-05/0.75, allocations: 7.984 kB / 1.585 GB, free: 8.746 MB / 1.279 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001128/0.7501, allocations: 44 kB / 1.585 GB, free: 8.703 MB / 1.279 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.195e-05/0.7501, allocations: 35.92 kB / 1.585 GB, free: 8.668 MB / 1.279 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002721/0.7528, allocations: 1.116 MB / 1.586 GB, free: 7.551 MB / 1.279 GB
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.01023/0.7631, allocations: 6.733 MB / 1.592 GB, free: 456 kB / 1.279 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002024/0.7651, allocations: 0.7687 MB / 1.593 GB, free: 15.65 MB / 1.295 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0008205/0.7659, allocations: 360.4 kB / 1.593 GB, free: 15.29 MB / 1.295 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.006982/0.7729, allocations: 1.866 MB / 1.595 GB, free: 13.43 MB / 1.295 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001257/0.7742, allocations: 0.4992 MB / 1.596 GB, free: 12.9 MB / 1.295 GB
Notification: Performance of pre-optimization done (n=67): time 2.815e-06/0.7742, allocations: 0 / 1.596 GB, free: 12.9 MB / 1.295 GB
Notification: Performance of matching and sorting (n=81): time 0.8319/1.606, allocations: 18.69 MB / 1.614 GB, free: 271.7 MB / 1.295 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.549e-05/1.606, allocations: 164.1 kB / 1.614 GB, free: 271.5 MB / 1.295 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003294/1.609, allocations: 2.021 MB / 1.616 GB, free: 271 MB / 1.295 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001541/1.61, allocations: 47.11 kB / 1.616 GB, free: 270.9 MB / 1.295 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0006941/1.61, allocations: 0.8775 MB / 1.617 GB, free: 270.3 MB / 1.295 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000274/1.61, allocations: 307 kB / 1.617 GB, free: 270.1 MB / 1.295 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004816/1.611, allocations: 338.4 kB / 1.618 GB, free: 269.9 MB / 1.295 GB
Notification: Performance of setup shared object (initialization): time 6.632e-05/1.611, allocations: 309.1 kB / 1.618 GB, free: 269.6 MB / 1.295 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001316/1.612, allocations: 0.6514 MB / 1.619 GB, free: 269.4 MB / 1.295 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00166/1.614, allocations: 1.058 MB / 1.62 GB, free: 268.7 MB / 1.295 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003208/1.617, allocations: 1.632 MB / 1.621 GB, free: 267.7 MB / 1.295 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.424e-05/1.617, allocations: 6.781 kB / 1.621 GB, free: 267.7 MB / 1.295 GB
Notification: Performance of matching and sorting (n=202) (initialization): time 0.005844/1.623, allocations: 2.119 MB / 1.623 GB, free: 266.9 MB / 1.295 GB
Notification: Performance of prepare postOptimizeDAE: time 3.171e-05/1.623, allocations: 10.08 kB / 1.623 GB, free: 266.9 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.459e-05/1.623, allocations: 11.03 kB / 1.623 GB, free: 266.9 MB / 1.295 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000797/1.624, allocations: 220.8 kB / 1.624 GB, free: 266.8 MB / 1.295 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001197/1.625, allocations: 304.1 kB / 1.624 GB, free: 266.8 MB / 1.295 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004225/1.629, allocations: 3.948 MB / 1.628 GB, free: 263.3 MB / 1.295 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00221/1.632, allocations: 120.8 kB / 1.628 GB, free: 263.3 MB / 1.295 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00018/1.632, allocations: 68.06 kB / 1.628 GB, free: 263.3 MB / 1.295 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 48
 * Number of states: 0 ()
 * Number of discrete variables: 6 ($PRE.bui.QHea.nextTimeEvent,$whenCondition1,bui.QHea.nextTimeEventScaled,$PRE.bui.QHea.nextTimeEventScaled,bui.QHea.nextTimeEvent,bui.IntEHea.local_reset)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (159):
 * Single equations (assignments): 155
 * Array equations: 1
 * Algorithm blocks: 0
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,1,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,8)}
Notification: Performance of prepare postOptimizeDAE: time 0.001067/1.633, allocations: 0.5629 MB / 1.628 GB, free: 262.9 MB / 1.295 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0007788/1.634, allocations: 196 kB / 1.629 GB, free: 262.8 MB / 1.295 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003636/1.637, allocations: 1.486 MB / 1.63 GB, free: 262.2 MB / 1.295 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.163e-05/1.637, allocations: 8.281 kB / 1.63 GB, free: 262.2 MB / 1.295 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.843e-06/1.637, allocations: 2.562 kB / 1.63 GB, free: 262.2 MB / 1.295 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00257/1.64, allocations: 1.266 MB / 1.631 GB, free: 261.5 MB / 1.295 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02599/1.666, allocations: 8.447 MB / 1.64 GB, free: 259.5 MB / 1.295 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.217e-05/1.666, allocations: 9.344 kB / 1.64 GB, free: 259.5 MB / 1.295 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008201/1.667, allocations: 185.1 kB / 1.64 GB, free: 259.5 MB / 1.295 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0005429/1.667, allocations: 153.9 kB / 1.64 GB, free: 259.4 MB / 1.295 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.304e-05/1.667, allocations: 29.34 kB / 1.64 GB, free: 259.4 MB / 1.295 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002732/1.67, allocations: 2.293 MB / 1.642 GB, free: 257.5 MB / 1.295 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 6.332e-06/1.67, allocations: 5.5 kB / 1.642 GB, free: 257.5 MB / 1.295 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004216/1.674, allocations: 1.903 MB / 1.644 GB, free: 256.5 MB / 1.295 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001091/1.675, allocations: 328.1 kB / 1.644 GB, free: 256.3 MB / 1.295 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003504/1.676, allocations: 32.64 kB / 1.644 GB, free: 256.3 MB / 1.295 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001311/1.677, allocations: 78.38 kB / 1.644 GB, free: 256.3 MB / 1.295 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000149/1.677, allocations: 83.09 kB / 1.644 GB, free: 256.2 MB / 1.295 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.387e-05/1.677, allocations: 35.17 kB / 1.645 GB, free: 256.2 MB / 1.295 GB
Notification: Performance of sorting global known variables: time 0.002049/1.679, allocations: 1.402 MB / 1.646 GB, free: 255.7 MB / 1.295 GB
Notification: Performance of sort global known variables: time 1.1e-07/1.679, allocations: 0 / 1.646 GB, free: 255.7 MB / 1.295 GB
Notification: Performance of remove unused functions: time 0.004605/1.684, allocations: 1.389 MB / 1.647 GB, free: 255.5 MB / 1.295 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 23
 * Number of states: 6 (bui.port_b.h_outflow,bui.IntEHea.y,bui.pumCNR.motSpe.y,bui.vol.VWat,bui.hIn.h_out,bui.hOut.h_out)
 * Number of discrete variables: 3 ($whenCondition1,bui.QHea.nextTimeEvent,bui.QHea.nextTimeEventScaled)
 * Number of discrete states: 2 (bui.QHea.nextTimeEvent,bui.QHea.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (80):
 * Single equations (assignments): 77
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(2,6)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.006934/1.691, allocations: 1.325 MB / 1.649 GB, free: 255.2 MB / 1.295 GB
Notification: Performance of simCode: created initialization part: time 0.003617/1.694, allocations: 1.575 MB / 1.65 GB, free: 254.5 MB / 1.295 GB
Notification: Performance of simCode: created event and clocks part: time 1.053e-05/1.694, allocations: 2.219 kB / 1.65 GB, free: 254.5 MB / 1.295 GB
Notification: Performance of simCode: created simulation system equations: time 0.001428/1.696, allocations: 0.6212 MB / 1.651 GB, free: 254.2 MB / 1.295 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004071/1.7, allocations: 0.9609 MB / 1.652 GB, free: 253.9 MB / 1.295 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006357/1.706, allocations: 3.914 MB / 1.655 GB, free: 251.7 MB / 1.295 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.000839/1.707, allocations: 1.48 MB / 1.657 GB, free: 250.8 MB / 1.295 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0006756/1.708, allocations: 183.2 kB / 1.657 GB, free: 250.8 MB / 1.295 GB
Notification: Performance of SimCode: time 1.133e-06/1.708, allocations: 0 / 1.657 GB, free: 250.8 MB / 1.295 GB
Notification: Performance of Templates: time 0.07631/1.784, allocations: 67.03 MB / 1.723 GB, free: 187.7 MB / 1.295 GB
"
[Timeout remaining time 298]
make -j1 -f Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.makefile [Timeout 300]
(rm -f Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.pipe ; mkfifo Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.pipe ; head -c 1048576 < Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.pipe >> ../files/Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.sim & ./Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.pipe 2>&1) [Timeout 400]
diffSimulationResults("Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_12.x/Buildings_DHC_Loads_Steam_Examples_BuildingTimeSeriesAtETS.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_12_Buildings.DHC.Loads.Steam.Examples.BuildingTimeSeriesAtETS.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 300]
""
[Timeout remaining time 300]
""

Variables in the reference:time,bui.Q_flow,bui.vol.m_flow,bui.vol.port_a.h_outflow,bui.vol.port_b.h_outflow,bui.sta_a.p,bui.vol.sta_a.p,bui.vol.sta_b.p

Variables in the result:bui.Q_flow,bui.sta_a.p,bui.vol.m_flow,bui.vol.port_a.h_outflow,bui.vol.port_b.h_outflow,bui.vol.sta_a.p,bui.vol.sta_b.p,time
[Calling sys.exit(0), Time elapsed: 22.57842236000579]