Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo)
Using package Modelica with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(Buildings.Fluid.Examples.Performance.Example1v2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pump.m_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2")
translateModel(Buildings.Fluid.Examples.Performance.Example1v2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pump.m_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001302/0.001302, allocations: 107.9 kB / 16.41 MB, free: 6.465 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001339/0.001339, allocations: 192.3 kB / 17.35 MB, free: 5.711 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.334/1.334, allocations: 222.9 MB / 241 MB, free: 15.09 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.556/2.556, allocations: 472.7 MB / 0.746 GB, free: 492 kB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001421/0.001421, allocations: 63.89 kB / 1.07 GB, free: 9.574 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7679/0.7693, allocations: 159.9 MB / 1.226 GB, free: 13.54 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.Example1v2): time 0.07649/0.8458, allocations: 81.1 MB / 1.306 GB, free: 12.17 MB / 1.029 GB
Notification: Performance of NFInst.instExpressions: time 0.03024/0.8761, allocations: 21.09 MB / 1.326 GB, free: 7.039 MB / 1.045 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004676/0.8809, allocations: 111.4 kB / 1.326 GB, free: 6.93 MB / 1.045 GB
Notification: Performance of NFTyping.typeComponents: time 0.006163/0.8871, allocations: 1.954 MB / 1.328 GB, free: 4.973 MB / 1.045 GB
Notification: Performance of NFTyping.typeBindings: time 0.008666/0.8958, allocations: 3.023 MB / 1.331 GB, free: 1.938 MB / 1.045 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006894/0.9027, allocations: 2.483 MB / 1.334 GB, free: 15.47 MB / 1.061 GB
Notification: Performance of NFFlatten.flatten: time 0.03369/0.9364, allocations: 29.79 MB / 1.363 GB, free: 1.59 MB / 1.076 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02408/0.9605, allocations: 17.07 MB / 1.379 GB, free: 404 kB / 1.092 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02295/0.9835, allocations: 11.41 MB / 1.39 GB, free: 5.02 MB / 1.107 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02095/1.004, allocations: 11.74 MB / 1.402 GB, free: 9.242 MB / 1.123 GB
Notification: Performance of NFPackage.collectConstants: time 0.005538/1.01, allocations: 1.289 MB / 1.403 GB, free: 7.953 MB / 1.123 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01146/1.022, allocations: 2.752 MB / 1.406 GB, free: 5.199 MB / 1.123 GB
Notification: Performance of NFScalarize.scalarize: time 0.007657/1.029, allocations: 3.775 MB / 1.41 GB, free: 1.414 MB / 1.123 GB
Notification: Performance of NFVerifyModel.verify: time 0.01451/1.044, allocations: 6.679 MB / 1.416 GB, free: 10.71 MB / 1.139 GB
Notification: Performance of NFConvertDAE.convert: time 0.02816/1.072, allocations: 19.14 MB / 1.435 GB, free: 7.504 MB / 1.154 GB
Notification: Performance of FrontEnd - DAE generated: time 5.15e-06/1.072, allocations: 4 kB / 1.435 GB, free: 7.5 MB / 1.154 GB
Notification: Performance of FrontEnd: time 1.433e-06/1.072, allocations: 0 / 1.435 GB, free: 7.5 MB / 1.154 GB
Notification: Performance of Transformations before backend: time 0.0006024/1.073, allocations: 0 / 1.435 GB, free: 7.5 MB / 1.154 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1422
 * Number of variables: 1422
Notification: Performance of Generate backend data structure: time 0.03996/1.113, allocations: 12.95 MB / 1.447 GB, free: 10.43 MB / 1.17 GB
Notification: Performance of prepare preOptimizeDAE: time 5.148e-05/1.113, allocations: 8.031 kB / 1.447 GB, free: 10.42 MB / 1.17 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009585/1.122, allocations: 1.442 MB / 1.449 GB, free: 8.969 MB / 1.17 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02529/1.148, allocations: 11.28 MB / 1.46 GB, free: 13.61 MB / 1.186 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004967/1.148, allocations: 439.1 kB / 1.46 GB, free: 13.18 MB / 1.186 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003668/1.152, allocations: 0.5897 MB / 1.461 GB, free: 12.59 MB / 1.186 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03261/1.184, allocations: 14.65 MB / 1.475 GB, free: 13.67 MB / 1.201 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002729/1.185, allocations: 19.89 kB / 1.475 GB, free: 13.65 MB / 1.201 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002977/1.188, allocations: 240 kB / 1.475 GB, free: 13.42 MB / 1.201 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001191/1.188, allocations: 139.9 kB / 1.476 GB, free: 13.28 MB / 1.201 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0334/1.221, allocations: 19.81 MB / 1.495 GB, free: 9.453 MB / 1.217 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.09896/1.32, allocations: 60.53 MB / 1.554 GB, free: 11.39 MB / 1.279 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01455/1.335, allocations: 9.17 MB / 1.563 GB, free: 2.219 MB / 1.279 GB
Notification: Performance of preOpt resolveLoops (simulation): time 1.2/2.535, allocations: 8.609 MB / 1.571 GB, free: 310.5 MB / 1.279 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.05109/2.586, allocations: 27.53 MB / 1.598 GB, free: 297.6 MB / 1.279 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01258/2.598, allocations: 7.645 MB / 1.606 GB, free: 292.9 MB / 1.279 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01407/2.612, allocations: 4.514 MB / 1.61 GB, free: 291.4 MB / 1.279 GB
Notification: Performance of pre-optimization done (n=298): time 2.52e-05/2.613, allocations: 0 / 1.61 GB, free: 291.4 MB / 1.279 GB
Notification: Performance of matching and sorting (n=298): time 0.05063/2.663, allocations: 23.85 MB / 1.633 GB, free: 269.3 MB / 1.279 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.035e-05/2.663, allocations: 85.75 kB / 1.633 GB, free: 269.2 MB / 1.279 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01414/2.677, allocations: 8.838 MB / 1.642 GB, free: 260.5 MB / 1.279 GB
Notification: Performance of collectPreVariables (initialization): time 0.002221/2.68, allocations: 105.7 kB / 1.642 GB, free: 260.4 MB / 1.279 GB
Notification: Performance of collectInitialEqns (initialization): time 0.004199/2.684, allocations: 4.279 MB / 1.646 GB, free: 256.7 MB / 1.279 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003153/2.687, allocations: 1.136 MB / 1.647 GB, free: 255.7 MB / 1.279 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003663/2.691, allocations: 1.777 MB / 1.649 GB, free: 253.9 MB / 1.279 GB
Notification: Performance of setup shared object (initialization): time 5.67e-05/2.691, allocations: 301.1 kB / 1.65 GB, free: 253.6 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008504/2.699, allocations: 6.734 MB / 1.656 GB, free: 246.9 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01035/2.71, allocations: 8.575 MB / 1.664 GB, free: 237.4 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0208/2.731, allocations: 15.59 MB / 1.68 GB, free: 221.1 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.168e-05/2.731, allocations: 16 kB / 1.68 GB, free: 221.1 MB / 1.279 GB
Notification: Performance of matching and sorting (n=644) (initialization): time 0.03746/2.768, allocations: 18.11 MB / 1.697 GB, free: 203 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 9.058e-05/2.768, allocations: 58.42 kB / 1.697 GB, free: 202.9 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.38e-05/2.768, allocations: 48 kB / 1.697 GB, free: 202.8 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06602/2.834, allocations: 11.6 MB / 1.709 GB, free: 191.3 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008458/2.843, allocations: 1.604 MB / 1.71 GB, free: 189.7 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004784/2.848, allocations: 3.776 MB / 1.714 GB, free: 185.8 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01065/2.858, allocations: 370 kB / 1.714 GB, free: 185.5 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002795/2.861, allocations: 0.5499 MB / 1.715 GB, free: 184.9 MB / 1.279 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01534/2.877, allocations: 9.127 MB / 1.724 GB, free: 175.8 MB / 1.279 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01094/2.888, allocations: 8.537 MB / 1.732 GB, free: 166.4 MB / 1.279 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.02106/2.909, allocations: 15.52 MB / 1.747 GB, free: 150.1 MB / 1.279 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.519e-05/2.909, allocations: 16 kB / 1.747 GB, free: 150.1 MB / 1.279 GB
Notification: Performance of matching and sorting (n=644) (initialization_lambda0): time 0.03454/2.943, allocations: 17.98 MB / 1.765 GB, free: 132.1 MB / 1.279 GB
Notification: Performance of prepare postOptimizeDAE: time 6.509e-05/2.943, allocations: 53.7 kB / 1.765 GB, free: 132 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.843e-05/2.943, allocations: 52.84 kB / 1.765 GB, free: 132 MB / 1.279 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.06298/3.006, allocations: 11.15 MB / 1.776 GB, free: 120.8 MB / 1.279 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008489/3.015, allocations: 1.592 MB / 1.777 GB, free: 119.2 MB / 1.279 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009008/3.024, allocations: 8.192 MB / 1.785 GB, free: 110.7 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01085/3.035, allocations: 372.8 kB / 1.786 GB, free: 110.4 MB / 1.279 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002847/3.038, allocations: 0.546 MB / 1.786 GB, free: 109.8 MB / 1.279 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 221
 * Number of states: 0 ()
 * Number of discrete variables: 8 (pulse.count,$PRE.pulse.count,pulse.T_start,$PRE.pulse.T_start,$whenCondition1,from_dp.y,nRes.y,allowFlowReversal.y)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (558):
 * Single equations (assignments): 552
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 3
 * 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): 3 systems
   {(2,5), (20,21), (2,5)}
Notification: Performance of prepare postOptimizeDAE: time 0.003867/3.042, allocations: 0.5014 MB / 1.787 GB, free: 109.3 MB / 1.279 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004213/3.046, allocations: 0.8383 MB / 1.788 GB, free: 108.5 MB / 1.279 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02949/3.075, allocations: 14.1 MB / 1.801 GB, free: 94.36 MB / 1.279 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01566/3.091, allocations: 10.67 MB / 1.812 GB, free: 83.58 MB / 1.279 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.509e-05/3.091, allocations: 3.938 kB / 1.812 GB, free: 83.57 MB / 1.279 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005856/3.097, allocations: 1.909 MB / 1.814 GB, free: 81.65 MB / 1.279 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003069/3.1, allocations: 71.97 kB / 1.814 GB, free: 81.58 MB / 1.279 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.007211/3.107, allocations: 216.2 kB / 1.814 GB, free: 81.38 MB / 1.279 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001616/3.109, allocations: 258.4 kB / 1.814 GB, free: 81.12 MB / 1.279 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.02088/3.13, allocations: 11.61 MB / 1.826 GB, free: 69.46 MB / 1.279 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.02697/3.157, allocations: 19.2 MB / 1.844 GB, free: 50.19 MB / 1.279 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.007619/3.165, allocations: 5.964 MB / 1.85 GB, free: 44.21 MB / 1.279 GB
Notification: Performance of sorting global known variables: time 0.01138/3.176, allocations: 6.079 MB / 1.856 GB, free: 38.17 MB / 1.279 GB
Notification: Performance of Backend: time 2.805e-06/3.176, allocations: 4 kB / 1.856 GB, free: 38.17 MB / 1.279 GB
Notification: Performance of simCode: created initialization part: time 0.03916/3.215, allocations: 19.83 MB / 1.875 GB, free: 18.38 MB / 1.279 GB
Notification: Performance of SimCode: time 0.0449/3.26, allocations: 22 MB / 1.897 GB, free: 12.52 MB / 1.295 GB
Notification: Performance of Templates: time 1.127/4.387, allocations: 280.2 MB / 2.171 GB, free: 0.5199 GB / 1.529 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.makefile
(rm -f Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.pipe >> ../files/Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.sim & ./Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Examples_Performance_Example1v2.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Examples.Performance.Example1v2.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches