Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.Examples.Performance.Example4.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 11.1.0-maint.11.x/package.mo", uses=false)
Using package Buildings with version 11.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/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.Example4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|res.m_flow",fileNamePrefix="Buildings_11_Buildings.Fluid.Examples.Performance.Example4")
translateModel(Buildings.Fluid.Examples.Performance.Example4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|res.m_flow",fileNamePrefix="Buildings_11_Buildings.Fluid.Examples.Performance.Example4")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.008241/0.008241, allocations: 97.66 kB / 15.73 MB, free: 6.047 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.002126/0.002126, allocations: 202.2 kB / 16.68 MB, free: 5.969 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.353/1.353, allocations: 222.9 MB / 240.4 MB, free: 4.336 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.898/2.898, allocations: 469.8 MB / 0.7425 GB, free: 7.293 MB / 0.5919 GB
Notification: Performance of FrontEnd - loaded program: time 0.001183/0.001183, allocations: 64.12 kB / 1.065 GB, free: 13.01 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2897/0.2909, allocations: 159.1 MB / 1.221 GB, free: 13.75 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.Example4): time 0.8783/1.169, allocations: 238.2 MB / 1.453 GB, free: 6.922 MB / 1.139 GB
Notification: Performance of NFInst.instExpressions: time 0.02279/1.192, allocations: 15.82 MB / 1.469 GB, free: 7.066 MB / 1.154 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002379/1.194, allocations: 63.62 kB / 1.469 GB, free: 7.004 MB / 1.154 GB
Notification: Performance of NFTyping.typeComponents: time 0.003057/1.197, allocations: 1.091 MB / 1.47 GB, free: 5.906 MB / 1.154 GB
Notification: Performance of NFTyping.typeBindings: time 0.007653/1.205, allocations: 3.098 MB / 1.473 GB, free: 2.797 MB / 1.154 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004371/1.209, allocations: 1.697 MB / 1.474 GB, free: 1.113 MB / 1.154 GB
Notification: Performance of NFFlatten.flatten: time 0.005119/1.215, allocations: 3.43 MB / 1.478 GB, free: 13.67 MB / 1.17 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001864/1.216, allocations: 1.069 MB / 1.479 GB, free: 12.57 MB / 1.17 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006469/1.223, allocations: 2.588 MB / 1.481 GB, free: 9.992 MB / 1.17 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002332/1.225, allocations: 1.074 MB / 1.482 GB, free: 8.93 MB / 1.17 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004076/1.226, allocations: 119.9 kB / 1.483 GB, free: 8.812 MB / 1.17 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006156/1.232, allocations: 3.11 MB / 1.486 GB, free: 5.695 MB / 1.17 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006221/1.232, allocations: 490.2 kB / 1.486 GB, free: 5.215 MB / 1.17 GB
Notification: Performance of NFVerifyModel.verify: time 0.001239/1.234, allocations: 0.8084 MB / 1.487 GB, free: 4.402 MB / 1.17 GB
Notification: Performance of NFConvertDAE.convert: time 0.005757/1.239, allocations: 2.978 MB / 1.49 GB, free: 1.414 MB / 1.17 GB
Notification: Performance of FrontEnd - DAE generated: time 6.572e-06/1.239, allocations: 4 kB / 1.49 GB, free: 1.41 MB / 1.17 GB
Notification: Performance of FrontEnd: time 1.393e-06/1.239, allocations: 4 kB / 1.49 GB, free: 1.406 MB / 1.17 GB
Notification: Performance of Transformations before backend: time 8.176e-05/1.24, allocations: 0 / 1.49 GB, free: 1.406 MB / 1.17 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 251
 * Number of variables: 251
Notification: Performance of Generate backend data structure: time 0.004487/1.244, allocations: 2.057 MB / 1.492 GB, free: 15.29 MB / 1.186 GB
Notification: Performance of prepare preOptimizeDAE: time 4.615e-05/1.244, allocations: 12.03 kB / 1.492 GB, free: 15.28 MB / 1.186 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002946/1.247, allocations: 0.5024 MB / 1.492 GB, free: 14.77 MB / 1.186 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002539/1.25, allocations: 1.181 MB / 1.493 GB, free: 13.54 MB / 1.186 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.287e-05/1.25, allocations: 78 kB / 1.493 GB, free: 13.46 MB / 1.186 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001709/1.25, allocations: 96 kB / 1.494 GB, free: 13.37 MB / 1.186 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002576/1.252, allocations: 1.354 MB / 1.495 GB, free: 11.89 MB / 1.186 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.611e-05/1.252, allocations: 3.938 kB / 1.495 GB, free: 11.89 MB / 1.186 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001203/1.253, allocations: 44 kB / 1.495 GB, free: 11.85 MB / 1.186 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.236e-05/1.253, allocations: 42 kB / 1.495 GB, free: 11.8 MB / 1.186 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002353/1.255, allocations: 1.054 MB / 1.496 GB, free: 10.75 MB / 1.186 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.00834/1.263, allocations: 7.404 MB / 1.503 GB, free: 2.867 MB / 1.186 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001521/1.265, allocations: 0.5251 MB / 1.504 GB, free: 2.336 MB / 1.186 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006073/1.265, allocations: 249.2 kB / 1.504 GB, free: 2.09 MB / 1.186 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003972/1.266, allocations: 287.6 kB / 1.504 GB, free: 1.754 MB / 1.186 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.149e-05/1.266, allocations: 46.77 kB / 1.504 GB, free: 1.699 MB / 1.186 GB
Notification: Performance of pre-optimization done (n=33): time 1.964e-06/1.266, allocations: 0 / 1.504 GB, free: 1.699 MB / 1.186 GB
Notification: Performance of matching and sorting (n=33): time 0.002427/1.268, allocations: 0.8376 MB / 1.505 GB, free: 0.8555 MB / 1.186 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.312e-05/1.268, allocations: 55.41 kB / 1.505 GB, free: 0.7891 MB / 1.186 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002063/1.27, allocations: 1.395 MB / 1.507 GB, free: 15.38 MB / 1.201 GB
Notification: Performance of collectPreVariables (initialization): time 6.912e-05/1.27, allocations: 33.7 kB / 1.507 GB, free: 15.34 MB / 1.201 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005774/1.271, allocations: 0.7196 MB / 1.507 GB, free: 14.62 MB / 1.201 GB
Notification: Performance of collectInitialBindings (initialization): time 0.00012/1.271, allocations: 123 kB / 1.507 GB, free: 14.5 MB / 1.201 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002682/1.271, allocations: 166.5 kB / 1.508 GB, free: 14.33 MB / 1.201 GB
Notification: Performance of setup shared object (initialization): time 0.0001242/1.271, allocations: 337.9 kB / 1.508 GB, free: 13.99 MB / 1.201 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008005/1.272, allocations: 312.6 kB / 1.508 GB, free: 13.68 MB / 1.201 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001077/1.273, allocations: 0.6902 MB / 1.509 GB, free: 12.82 MB / 1.201 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001746/1.275, allocations: 0.9301 MB / 1.51 GB, free: 11.73 MB / 1.201 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.085e-06/1.275, allocations: 7.938 kB / 1.51 GB, free: 11.73 MB / 1.201 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.002418/1.278, allocations: 1.059 MB / 1.511 GB, free: 10.66 MB / 1.201 GB
Notification: Performance of prepare postOptimizeDAE: time 2.305e-05/1.278, allocations: 12 kB / 1.511 GB, free: 10.65 MB / 1.201 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.699e-05/1.278, allocations: 12 kB / 1.511 GB, free: 10.64 MB / 1.201 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.802e-05/1.278, allocations: 16 kB / 1.511 GB, free: 10.62 MB / 1.201 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008858/1.278, allocations: 211.6 kB / 1.511 GB, free: 10.41 MB / 1.201 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2e-05/1.279, allocations: 15.94 kB / 1.511 GB, free: 10.4 MB / 1.201 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001368/1.28, allocations: 187 kB / 1.511 GB, free: 10.21 MB / 1.201 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.343e-05/1.28, allocations: 43.98 kB / 1.511 GB, free: 10.17 MB / 1.201 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001217/1.281, allocations: 0.5604 MB / 1.512 GB, free: 9.609 MB / 1.201 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001085/1.282, allocations: 0.6892 MB / 1.512 GB, free: 8.742 MB / 1.201 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001735/1.284, allocations: 0.9255 MB / 1.513 GB, free: 7.656 MB / 1.201 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 8.405e-06/1.284, allocations: 4 kB / 1.513 GB, free: 7.652 MB / 1.201 GB
Notification: Performance of matching and sorting (n=88) (initialization_lambda0): time 0.002388/1.286, allocations: 1.051 MB / 1.514 GB, free: 6.594 MB / 1.201 GB
Notification: Performance of prepare postOptimizeDAE: time 1.733e-05/1.286, allocations: 13.66 kB / 1.514 GB, free: 6.582 MB / 1.201 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.415e-05/1.286, allocations: 12 kB / 1.514 GB, free: 6.57 MB / 1.201 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.69e-05/1.286, allocations: 16.09 kB / 1.514 GB, free: 6.555 MB / 1.201 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008638/1.287, allocations: 212.2 kB / 1.515 GB, free: 6.348 MB / 1.201 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.308e-05/1.287, allocations: 27.86 kB / 1.515 GB, free: 6.32 MB / 1.201 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001335/1.289, allocations: 135.5 kB / 1.515 GB, free: 6.188 MB / 1.201 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.183e-05/1.289, allocations: 43.98 kB / 1.515 GB, free: 6.145 MB / 1.201 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 52
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (88):
 * Single equations (assignments): 88
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0003203/1.289, allocations: 236 kB / 1.515 GB, free: 5.906 MB / 1.201 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000342/1.289, allocations: 151 kB / 1.515 GB, free: 5.758 MB / 1.201 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001741/1.291, allocations: 0.6365 MB / 1.516 GB, free: 5.109 MB / 1.201 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.961e-06/1.291, allocations: 4 kB / 1.516 GB, free: 5.105 MB / 1.201 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.08e-06/1.291, allocations: 0 / 1.516 GB, free: 5.105 MB / 1.201 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.342e-06/1.291, allocations: 8 kB / 1.516 GB, free: 5.098 MB / 1.201 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003868/1.295, allocations: 1.89 MB / 1.518 GB, free: 3.098 MB / 1.201 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.233e-06/1.295, allocations: 4.031 kB / 1.518 GB, free: 3.094 MB / 1.201 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0005263/1.296, allocations: 87.86 kB / 1.518 GB, free: 3.008 MB / 1.201 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.358e-05/1.296, allocations: 11.94 kB / 1.518 GB, free: 2.996 MB / 1.201 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.868e-05/1.296, allocations: 11.98 kB / 1.518 GB, free: 2.984 MB / 1.201 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 8.405e-06/1.296, allocations: 11.94 kB / 1.518 GB, free: 2.973 MB / 1.201 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.918e-06/1.296, allocations: 7.938 kB / 1.518 GB, free: 2.965 MB / 1.201 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001621/1.297, allocations: 0.8121 MB / 1.519 GB, free: 2.086 MB / 1.201 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.000584/1.298, allocations: 307.8 kB / 1.519 GB, free: 1.766 MB / 1.201 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000303/1.298, allocations: 8 kB / 1.519 GB, free: 1.758 MB / 1.201 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001139/1.299, allocations: 71.92 kB / 1.519 GB, free: 1.688 MB / 1.201 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.389e-05/1.299, allocations: 35.84 kB / 1.519 GB, free: 1.652 MB / 1.201 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.186e-05/1.299, allocations: 19.98 kB / 1.519 GB, free: 1.633 MB / 1.201 GB
Notification: Performance of sorting global known variables: time 0.001585/1.301, allocations: 1.009 MB / 1.52 GB, free: 0.6289 MB / 1.201 GB
Notification: Performance of sort global known variables: time 9.1e-08/1.301, allocations: 0 / 1.52 GB, free: 0.6289 MB / 1.201 GB
Notification: Performance of remove unused functions: time 0.002008/1.303, allocations: 0.5814 MB / 1.521 GB, free: 48 kB / 1.201 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 16
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (32):
 * Single equations (assignments): 32
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0006269/1.304, allocations: 258.9 kB / 1.521 GB, free: 15.79 MB / 1.217 GB
Notification: Performance of simCode: created initialization part: time 0.002828/1.306, allocations: 1.09 MB / 1.522 GB, free: 14.71 MB / 1.217 GB
Notification: Performance of simCode: created event and clocks part: time 5.21e-06/1.306, allocations: 3.938 kB / 1.522 GB, free: 14.7 MB / 1.217 GB
Notification: Performance of simCode: created simulation system equations: time 0.0006581/1.307, allocations: 246.8 kB / 1.522 GB, free: 14.46 MB / 1.217 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003401/1.311, allocations: 0.7319 MB / 1.523 GB, free: 13.74 MB / 1.217 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.005292/1.316, allocations: 2.301 MB / 1.525 GB, free: 11.36 MB / 1.217 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0009244/1.317, allocations: 1.186 MB / 1.526 GB, free: 10.14 MB / 1.217 GB
Notification: Performance of simCode: alias equations: time 0.001474/1.318, allocations: 387.8 kB / 1.527 GB, free: 9.758 MB / 1.217 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003137/1.319, allocations: 91.42 kB / 1.527 GB, free: 9.668 MB / 1.217 GB
Notification: Performance of SimCode: time 1.012e-06/1.319, allocations: 0 / 1.527 GB, free: 9.668 MB / 1.217 GB
Notification: Performance of Templates: time 0.04295/1.362, allocations: 25.31 MB / 1.551 GB, free: 0.6797 MB / 1.232 GB
make -j1 -f Buildings_11_Buildings.Fluid.Examples.Performance.Example4.makefile
(rm -f Buildings_11_Buildings.Fluid.Examples.Performance.Example4.pipe ; mkfifo Buildings_11_Buildings.Fluid.Examples.Performance.Example4.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.Examples.Performance.Example4.pipe >> ../files/Buildings_11_Buildings.Fluid.Examples.Performance.Example4.sim & ./Buildings_11_Buildings.Fluid.Examples.Performance.Example4  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Fluid.Examples.Performance.Example4.pipe 2>&1)
diffSimulationResults("Buildings_11_Buildings.Fluid.Examples.Performance.Example4_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_Fluid_Examples_Performance_Example4.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.Fluid.Examples.Performance.Example4.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches