Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_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.0.1-master/package.mo", uses=false)
Using package Buildings with version 11.0.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-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.Example4,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|res.m_flow",fileNamePrefix="Buildings_latest_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_latest_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.001527/0.001527, allocations: 116.1 kB / 16.42 MB, free: 5.992 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.001794/0.001794, allocations: 184.8 kB / 17.35 MB, free: 5.602 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.309/1.309, allocations: 222.9 MB / 241.1 MB, free: 15.18 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.546/2.546, allocations: 469.4 MB / 0.7428 GB, free: 3.578 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001534/0.001534, allocations: 67.89 kB / 1.065 GB, free: 13.79 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7494/0.7509, allocations: 159.1 MB / 1.221 GB, free: 2.324 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.Performance.Example4): time 0.228/0.9789, allocations: 237.6 MB / 1.453 GB, free: 3.855 MB / 1.17 GB
Notification: Performance of NFInst.instExpressions: time 0.01911/0.9981, allocations: 15.79 MB / 1.468 GB, free: 4.016 MB / 1.186 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001797/0.9999, allocations: 63.62 kB / 1.468 GB, free: 3.953 MB / 1.186 GB
Notification: Performance of NFTyping.typeComponents: time 0.002303/1.002, allocations: 1.064 MB / 1.469 GB, free: 2.883 MB / 1.186 GB
Notification: Performance of NFTyping.typeBindings: time 0.006622/1.009, allocations: 3.107 MB / 1.472 GB, free: 15.77 MB / 1.201 GB
Notification: Performance of NFTyping.typeClassSections: time 0.003695/1.013, allocations: 1.695 MB / 1.474 GB, free: 14.08 MB / 1.201 GB
Notification: Performance of NFFlatten.flatten: time 0.004557/1.017, allocations: 3.449 MB / 1.477 GB, free: 10.62 MB / 1.201 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001899/1.019, allocations: 1.287 MB / 1.479 GB, free: 9.297 MB / 1.201 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.006213/1.025, allocations: 2.576 MB / 1.481 GB, free: 6.723 MB / 1.201 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002029/1.027, allocations: 1.089 MB / 1.482 GB, free: 5.641 MB / 1.201 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003214/1.028, allocations: 116 kB / 1.482 GB, free: 5.527 MB / 1.201 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.005842/1.034, allocations: 3.106 MB / 1.485 GB, free: 2.414 MB / 1.201 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006459/1.034, allocations: 474.4 kB / 1.486 GB, free: 1.949 MB / 1.201 GB
Notification: Performance of NFVerifyModel.verify: time 0.001478/1.036, allocations: 0.8085 MB / 1.487 GB, free: 1.137 MB / 1.201 GB
Notification: Performance of NFConvertDAE.convert: time 0.006192/1.042, allocations: 2.968 MB / 1.49 GB, free: 14.16 MB / 1.217 GB
Notification: Performance of FrontEnd - DAE generated: time 4.569e-06/1.042, allocations: 0 / 1.49 GB, free: 14.16 MB / 1.217 GB
Notification: Performance of FrontEnd: time 1.964e-06/1.042, allocations: 0 / 1.49 GB, free: 14.16 MB / 1.217 GB
Notification: Performance of Transformations before backend: time 8.073e-05/1.042, allocations: 0 / 1.49 GB, free: 14.16 MB / 1.217 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.004974/1.047, allocations: 2.007 MB / 1.492 GB, free: 12.1 MB / 1.217 GB
Notification: Performance of prepare preOptimizeDAE: time 4.765e-05/1.047, allocations: 8.625 kB / 1.492 GB, free: 12.09 MB / 1.217 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002855/1.05, allocations: 0.4976 MB / 1.492 GB, free: 11.59 MB / 1.217 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002446/1.052, allocations: 1.172 MB / 1.493 GB, free: 10.36 MB / 1.217 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.719e-05/1.052, allocations: 78 kB / 1.493 GB, free: 10.29 MB / 1.217 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000156/1.053, allocations: 96 kB / 1.493 GB, free: 10.19 MB / 1.217 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002421/1.055, allocations: 1.35 MB / 1.495 GB, free: 8.723 MB / 1.217 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.434e-05/1.055, allocations: 7.938 kB / 1.495 GB, free: 8.715 MB / 1.217 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001098/1.055, allocations: 44 kB / 1.495 GB, free: 8.672 MB / 1.217 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.234e-05/1.055, allocations: 41.98 kB / 1.495 GB, free: 8.629 MB / 1.217 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002466/1.058, allocations: 1.05 MB / 1.496 GB, free: 7.582 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.007713/1.065, allocations: 7.395 MB / 1.503 GB, free: 15.7 MB / 1.232 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001543/1.067, allocations: 0.5347 MB / 1.504 GB, free: 15.16 MB / 1.232 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0006251/1.068, allocations: 257.2 kB / 1.504 GB, free: 14.9 MB / 1.232 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003641/1.068, allocations: 295.4 kB / 1.504 GB, free: 14.56 MB / 1.232 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.171e-05/1.068, allocations: 38.84 kB / 1.504 GB, free: 14.52 MB / 1.232 GB
Notification: Performance of pre-optimization done (n=33): time 2.014e-06/1.068, allocations: 0 / 1.504 GB, free: 14.52 MB / 1.232 GB
Notification: Performance of matching and sorting (n=33): time 0.002383/1.07, allocations: 0.8407 MB / 1.505 GB, free: 13.67 MB / 1.232 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.917e-05/1.071, allocations: 55.34 kB / 1.505 GB, free: 13.6 MB / 1.232 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001865/1.072, allocations: 1.399 MB / 1.506 GB, free: 12.19 MB / 1.232 GB
Notification: Performance of collectPreVariables (initialization): time 6.011e-05/1.072, allocations: 29.7 kB / 1.506 GB, free: 12.16 MB / 1.232 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005311/1.073, allocations: 0.7026 MB / 1.507 GB, free: 11.45 MB / 1.232 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001069/1.073, allocations: 122.3 kB / 1.507 GB, free: 11.33 MB / 1.232 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002428/1.073, allocations: 162.4 kB / 1.507 GB, free: 11.16 MB / 1.232 GB
Notification: Performance of setup shared object (initialization): time 0.0001125/1.073, allocations: 338 kB / 1.508 GB, free: 10.83 MB / 1.232 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008534/1.074, allocations: 312.6 kB / 1.508 GB, free: 10.52 MB / 1.232 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001093/1.075, allocations: 0.6892 MB / 1.509 GB, free: 9.66 MB / 1.232 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001759/1.077, allocations: 0.9341 MB / 1.51 GB, free: 8.566 MB / 1.232 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.966e-06/1.077, allocations: 4 kB / 1.51 GB, free: 8.562 MB / 1.232 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.002361/1.08, allocations: 1.046 MB / 1.511 GB, free: 7.508 MB / 1.232 GB
Notification: Performance of prepare postOptimizeDAE: time 2.164e-05/1.08, allocations: 12 kB / 1.511 GB, free: 7.496 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.625e-05/1.08, allocations: 12 kB / 1.511 GB, free: 7.484 MB / 1.232 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.807e-05/1.08, allocations: 16 kB / 1.511 GB, free: 7.469 MB / 1.232 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008774/1.081, allocations: 207.9 kB / 1.511 GB, free: 7.266 MB / 1.232 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.818e-05/1.081, allocations: 27.86 kB / 1.511 GB, free: 7.238 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001274/1.082, allocations: 170.7 kB / 1.511 GB, free: 7.07 MB / 1.232 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.655e-05/1.082, allocations: 43.98 kB / 1.511 GB, free: 7.027 MB / 1.232 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001189/1.083, allocations: 0.5682 MB / 1.512 GB, free: 6.457 MB / 1.232 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001089/1.084, allocations: 0.6853 MB / 1.512 GB, free: 5.594 MB / 1.232 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001711/1.086, allocations: 0.9255 MB / 1.513 GB, free: 4.508 MB / 1.232 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.323e-06/1.086, allocations: 4 kB / 1.513 GB, free: 4.504 MB / 1.232 GB
Notification: Performance of matching and sorting (n=88) (initialization_lambda0): time 0.002347/1.088, allocations: 1.053 MB / 1.514 GB, free: 3.441 MB / 1.232 GB
Notification: Performance of prepare postOptimizeDAE: time 1.558e-05/1.088, allocations: 11.94 kB / 1.514 GB, free: 3.43 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.061e-05/1.088, allocations: 12 kB / 1.514 GB, free: 3.418 MB / 1.232 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.447e-05/1.088, allocations: 16.78 kB / 1.514 GB, free: 3.402 MB / 1.232 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008186/1.089, allocations: 207.7 kB / 1.514 GB, free: 3.199 MB / 1.232 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.919e-05/1.089, allocations: 23.92 kB / 1.514 GB, free: 3.176 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001221/1.091, allocations: 127.4 kB / 1.515 GB, free: 3.051 MB / 1.232 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.842e-05/1.091, allocations: 47.98 kB / 1.515 GB, free: 3.004 MB / 1.232 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.0002085/1.091, allocations: 232 kB / 1.515 GB, free: 2.77 MB / 1.232 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002127/1.091, allocations: 142.2 kB / 1.515 GB, free: 2.629 MB / 1.232 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001639/1.093, allocations: 0.6366 MB / 1.516 GB, free: 1.977 MB / 1.232 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.42e-06/1.093, allocations: 4 kB / 1.516 GB, free: 1.973 MB / 1.232 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.844e-06/1.093, allocations: 0 / 1.516 GB, free: 1.973 MB / 1.232 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004759/1.093, allocations: 287.2 kB / 1.516 GB, free: 1.672 MB / 1.232 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002096/1.093, allocations: 4 kB / 1.516 GB, free: 1.668 MB / 1.232 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009496/1.094, allocations: 64.02 kB / 1.516 GB, free: 1.605 MB / 1.232 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 7.324e-05/1.094, allocations: 23.95 kB / 1.516 GB, free: 1.582 MB / 1.232 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001615/1.096, allocations: 0.5902 MB / 1.517 GB, free: 0.9844 MB / 1.232 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001484/1.098, allocations: 0.7773 MB / 1.517 GB, free: 196 kB / 1.232 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.000604/1.098, allocations: 219.8 kB / 1.518 GB, free: 15.98 MB / 1.248 GB
Notification: Performance of sorting global known variables: time 0.001357/1.1, allocations: 0.9482 MB / 1.518 GB, free: 15.03 MB / 1.248 GB
Notification: Performance of Backend: time 1.533e-06/1.1, allocations: 4 kB / 1.518 GB, free: 15.03 MB / 1.248 GB
Notification: Performance of simCode: created initialization part: time 0.004316/1.104, allocations: 1.584 MB / 1.52 GB, free: 13.45 MB / 1.248 GB
Notification: Performance of SimCode: time 0.005383/1.109, allocations: 2.926 MB / 1.523 GB, free: 10.47 MB / 1.248 GB
Notification: Performance of Templates: time 0.05179/1.161, allocations: 33.48 MB / 1.556 GB, free: 9.262 MB / 1.279 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Examples.Performance.Example4.makefile
(rm -f Buildings_latest_Buildings.Fluid.Examples.Performance.Example4.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Examples.Performance.Example4.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Examples.Performance.Example4.pipe >> ../files/Buildings_latest_Buildings.Fluid.Examples.Performance.Example4.sim & ./Buildings_latest_Buildings.Fluid.Examples.Performance.Example4  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Examples.Performance.Example4.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.Examples.Performance.Example4_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_Examples_Performance_Example4.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.Examples.Performance.Example4.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches