Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.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.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol.1..p|vol.2..p|vol.3..p|vol.1..T|vol.2..T|vol.3..T",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir")
translateModel(Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol.1..p|vol.2..p|vol.3..p|vol.1..T|vol.2..T|vol.3..T",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001695/0.001695, allocations: 116.1 kB / 16.42 MB, free: 6.496 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.001968/0.001968, allocations: 187.9 kB / 17.35 MB, free: 5.762 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.409/1.409, allocations: 222.9 MB / 241.1 MB, free: 15.16 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.0.1-master/package.mo): time 2.552/2.552, allocations: 461.9 MB / 0.7355 GB, free: 11.11 MB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001428/0.001429, allocations: 64.12 kB / 1.055 GB, free: 7.734 MB / 0.8262 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6957/0.6972, allocations: 157.4 MB / 1.208 GB, free: 13.66 MB / 0.9356 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir): time 0.1842/0.8814, allocations: 183.1 MB / 1.387 GB, free: 5.859 MB / 1.107 GB
Notification: Performance of NFInst.instExpressions: time 0.009048/0.8905, allocations: 6.683 MB / 1.394 GB, free: 15.16 MB / 1.123 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.0007541/0.8912, allocations: 35.75 kB / 1.394 GB, free: 15.13 MB / 1.123 GB
Notification: Performance of NFTyping.typeComponents: time 0.001125/0.8924, allocations: 425.4 kB / 1.394 GB, free: 14.71 MB / 1.123 GB
Notification: Performance of NFTyping.typeBindings: time 0.003149/0.8956, allocations: 1.415 MB / 1.396 GB, free: 13.29 MB / 1.123 GB
Notification: Performance of NFTyping.typeClassSections: time 0.001801/0.8974, allocations: 0.774 MB / 1.396 GB, free: 12.52 MB / 1.123 GB
Notification: Performance of NFFlatten.flatten: time 0.003941/0.9013, allocations: 3.976 MB / 1.4 GB, free: 8.535 MB / 1.123 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001665/0.903, allocations: 1.582 MB / 1.402 GB, free: 6.922 MB / 1.123 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.00231/0.9053, allocations: 1.559 MB / 1.403 GB, free: 5.359 MB / 1.123 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001946/0.9073, allocations: 1.214 MB / 1.404 GB, free: 4.152 MB / 1.123 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002322/0.9075, allocations: 132 kB / 1.405 GB, free: 4.023 MB / 1.123 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002583/0.9101, allocations: 1.493 MB / 1.406 GB, free: 2.527 MB / 1.123 GB
Notification: Performance of NFScalarize.scalarize: time 0.0005518/0.9107, allocations: 0.5766 MB / 1.407 GB, free: 1.949 MB / 1.123 GB
Notification: Performance of NFVerifyModel.verify: time 0.0009503/0.9116, allocations: 0.8517 MB / 1.407 GB, free: 1.094 MB / 1.123 GB
Notification: Performance of NFConvertDAE.convert: time 0.00309/0.9147, allocations: 2.754 MB / 1.41 GB, free: 14.33 MB / 1.139 GB
Notification: Performance of FrontEnd - DAE generated: time 3.567e-06/0.9148, allocations: 0 / 1.41 GB, free: 14.33 MB / 1.139 GB
Notification: Performance of FrontEnd: time 1.583e-06/0.9148, allocations: 0 / 1.41 GB, free: 14.33 MB / 1.139 GB
Notification: Performance of Transformations before backend: time 1.771e-05/0.9148, allocations: 0 / 1.41 GB, free: 14.33 MB / 1.139 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 247
 * Number of variables: 247
Notification: Performance of Generate backend data structure: time 0.002877/0.9177, allocations: 1.924 MB / 1.412 GB, free: 12.35 MB / 1.139 GB
Notification: Performance of prepare preOptimizeDAE: time 3.83e-05/0.9177, allocations: 8.031 kB / 1.412 GB, free: 12.34 MB / 1.139 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003132/0.9208, allocations: 0.4938 MB / 1.413 GB, free: 11.85 MB / 1.139 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002319/0.9232, allocations: 1.272 MB / 1.414 GB, free: 10.53 MB / 1.139 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.151e-05/0.9232, allocations: 74 kB / 1.414 GB, free: 10.46 MB / 1.139 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001674/0.9234, allocations: 100 kB / 1.414 GB, free: 10.36 MB / 1.139 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002037/0.9255, allocations: 1.346 MB / 1.415 GB, free: 9.012 MB / 1.139 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.606e-05/0.9255, allocations: 0 / 1.415 GB, free: 9.012 MB / 1.139 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001123/0.9256, allocations: 51.92 kB / 1.415 GB, free: 8.961 MB / 1.139 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.709e-05/0.9257, allocations: 37.98 kB / 1.415 GB, free: 8.922 MB / 1.139 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001888/0.9276, allocations: 1.284 MB / 1.417 GB, free: 7.637 MB / 1.139 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.006198/0.9338, allocations: 4.951 MB / 1.421 GB, free: 2.285 MB / 1.139 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001459/0.9352, allocations: 1.015 MB / 1.422 GB, free: 1.266 MB / 1.139 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0007566/0.936, allocations: 0.5768 MB / 1.423 GB, free: 0.6875 MB / 1.139 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003038/0.9363, allocations: 198.8 kB / 1.423 GB, free: 468 kB / 1.139 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.211e-05/0.9364, allocations: 59.14 kB / 1.423 GB, free: 400 kB / 1.139 GB
Notification: Performance of pre-optimization done (n=78): time 2.004e-06/0.9364, allocations: 0 / 1.423 GB, free: 400 kB / 1.139 GB
Notification: Performance of matching and sorting (n=81): time 0.005041/0.9414, allocations: 3.014 MB / 1.426 GB, free: 13.32 MB / 1.154 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.178e-05/0.9415, allocations: 60.06 kB / 1.426 GB, free: 13.25 MB / 1.154 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001107/0.9426, allocations: 0.9887 MB / 1.427 GB, free: 12.23 MB / 1.154 GB
Notification: Performance of collectPreVariables (initialization): time 7.357e-05/0.9427, allocations: 45.7 kB / 1.427 GB, free: 12.18 MB / 1.154 GB
Notification: Performance of collectInitialEqns (initialization): time 0.000383/0.9431, allocations: 0.5313 MB / 1.428 GB, free: 11.64 MB / 1.154 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002395/0.9433, allocations: 287.8 kB / 1.428 GB, free: 11.36 MB / 1.154 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002344/0.9435, allocations: 158.6 kB / 1.428 GB, free: 11.2 MB / 1.154 GB
Notification: Performance of setup shared object (initialization): time 0.0001166/0.9437, allocations: 345.9 kB / 1.429 GB, free: 10.86 MB / 1.154 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006043/0.9443, allocations: 452.5 kB / 1.429 GB, free: 10.41 MB / 1.154 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007401/0.945, allocations: 0.5979 MB / 1.43 GB, free: 9.762 MB / 1.154 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00137/0.9464, allocations: 1.086 MB / 1.431 GB, free: 8.637 MB / 1.154 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.154e-06/0.9464, allocations: 0 / 1.431 GB, free: 8.637 MB / 1.154 GB
Notification: Performance of matching and sorting (n=97) (initialization): time 0.001802/0.9482, allocations: 1.262 MB / 1.432 GB, free: 7.367 MB / 1.154 GB
Notification: Performance of prepare postOptimizeDAE: time 1.503e-05/0.9482, allocations: 4 kB / 1.432 GB, free: 7.363 MB / 1.154 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.206e-06/0.9483, allocations: 4 kB / 1.432 GB, free: 7.359 MB / 1.154 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002169/0.9485, allocations: 73.16 kB / 1.432 GB, free: 7.285 MB / 1.154 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001013/0.9495, allocations: 203.8 kB / 1.432 GB, free: 7.086 MB / 1.154 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002304/0.9518, allocations: 3.185 MB / 1.435 GB, free: 3.711 MB / 1.154 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001046/0.9529, allocations: 79.89 kB / 1.435 GB, free: 3.633 MB / 1.154 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.709e-05/0.953, allocations: 35.98 kB / 1.435 GB, free: 3.598 MB / 1.154 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001125/0.9541, allocations: 0.8959 MB / 1.436 GB, free: 2.699 MB / 1.154 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0007069/0.9548, allocations: 0.5902 MB / 1.437 GB, free: 2.062 MB / 1.154 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.00136/0.9562, allocations: 1.078 MB / 1.438 GB, free: 0.9453 MB / 1.154 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.034e-06/0.9562, allocations: 4 kB / 1.438 GB, free: 0.9414 MB / 1.154 GB
Notification: Performance of matching and sorting (n=97) (initialization_lambda0): time 0.001793/0.958, allocations: 1.25 MB / 1.439 GB, free: 15.68 MB / 1.17 GB
Notification: Performance of prepare postOptimizeDAE: time 1.205e-05/0.958, allocations: 8.344 kB / 1.439 GB, free: 15.67 MB / 1.17 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.717e-06/0.958, allocations: 4 kB / 1.439 GB, free: 15.67 MB / 1.17 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001712/0.9582, allocations: 72.75 kB / 1.439 GB, free: 15.59 MB / 1.17 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000692/0.9589, allocations: 179.8 kB / 1.439 GB, free: 15.42 MB / 1.17 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00164/0.9606, allocations: 2.002 MB / 1.441 GB, free: 13.27 MB / 1.17 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001042/0.9616, allocations: 71.89 kB / 1.441 GB, free: 13.2 MB / 1.17 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.623e-05/0.9617, allocations: 32.19 kB / 1.441 GB, free: 13.17 MB / 1.17 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 12
 * 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 (92):
 * Single equations (assignments): 89
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 2 systems
   {1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,5,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of prepare postOptimizeDAE: time 0.0002405/0.9619, allocations: 240 kB / 1.442 GB, free: 12.93 MB / 1.17 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001788/0.9621, allocations: 110.7 kB / 1.442 GB, free: 12.82 MB / 1.17 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001812/0.9639, allocations: 1.2 MB / 1.443 GB, free: 11.61 MB / 1.17 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001517/0.9655, allocations: 1.256 MB / 1.444 GB, free: 10.28 MB / 1.17 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.811e-06/0.9655, allocations: 4 kB / 1.444 GB, free: 10.28 MB / 1.17 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006471/0.9661, allocations: 323.6 kB / 1.444 GB, free: 9.941 MB / 1.17 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001293/0.9663, allocations: 23.98 kB / 1.444 GB, free: 9.918 MB / 1.17 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008246/0.9671, allocations: 62.06 kB / 1.444 GB, free: 9.859 MB / 1.17 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.852e-05/0.9672, allocations: 48.58 kB / 1.445 GB, free: 9.812 MB / 1.17 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.002596/0.9698, allocations: 1.44 MB / 1.446 GB, free: 8.355 MB / 1.17 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.002292/0.9721, allocations: 1.911 MB / 1.448 GB, free: 6.426 MB / 1.17 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0006494/0.9728, allocations: 0.532 MB / 1.448 GB, free: 5.891 MB / 1.17 GB
Notification: Performance of sorting global known variables: time 0.0008288/0.9736, allocations: 0.6996 MB / 1.449 GB, free: 5.18 MB / 1.17 GB
Notification: Performance of Backend: time 4.01e-07/0.9736, allocations: 0 / 1.449 GB, free: 5.18 MB / 1.17 GB
Notification: Performance of simCode: created initialization part: time 0.003656/0.9773, allocations: 1.892 MB / 1.451 GB, free: 3.27 MB / 1.17 GB
Notification: Performance of SimCode: time 0.005795/0.9831, allocations: 3.671 MB / 1.454 GB, free: 15.56 MB / 1.186 GB
Notification: Performance of Templates: time 0.04598/1.029, allocations: 32.97 MB / 1.487 GB, free: 14.87 MB / 1.217 GB
make -j1 -f Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.makefile
(rm -f Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.pipe ; mkfifo Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.pipe >> ../files/Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.sim & ./Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.pipe 2>&1)
diffSimulationResults("Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir_res.mat","/mnt/ReferenceFiles/Buildings/csv/master/Buildings_Fluid_MixingVolumes_BaseClasses_Validation_MixingVolumeHeatPortAir.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_latest_Buildings.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortAir.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches