Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.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.MixingVolumes.Validation.MixingVolumeInitialization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol1.T_start|vol1.T|vol1.ports.1..h_outflow|vol1.ports.2..h_outflow|pipe1.port_b.h_outflow",fileNamePrefix="Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization")
translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|vol1.T_start|vol1.T|vol1.ports.1..h_outflow|vol1.ports.2..h_outflow|pipe1.port_b.h_outflow",fileNamePrefix="Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001925/0.001925, allocations: 119.8 kB / 16.81 MB, free: 5.758 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.002249/0.002249, allocations: 196.7 kB / 17.77 MB, free: 5.125 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.415/1.415, allocations: 225.6 MB / 244.2 MB, free: 13.89 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 11.1.0-maint.11.x/package.mo): time 2.751/2.751, allocations: 476.7 MB / 0.7556 GB, free: 11.3 MB / 0.6231 GB
Notification: Performance of FrontEnd - loaded program: time 0.002018/0.002018, allocations: 68 kB / 1.097 GB, free: 11.74 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3334/0.3354, allocations: 168.7 MB / 1.262 GB, free: 12.95 MB / 0.9825 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization): time 0.2162/0.5516, allocations: 188.5 MB / 1.446 GB, free: 15.73 MB / 1.17 GB
Notification: Performance of NFInst.instExpressions: time 0.01624/0.5678, allocations: 10.81 MB / 1.457 GB, free: 4.891 MB / 1.17 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001154/0.569, allocations: 43.75 kB / 1.457 GB, free: 4.848 MB / 1.17 GB
Notification: Performance of NFTyping.typeComponents: time 0.001507/0.5705, allocations: 0.5126 MB / 1.457 GB, free: 4.332 MB / 1.17 GB
Notification: Performance of NFTyping.typeBindings: time 0.006847/0.5773, allocations: 2.664 MB / 1.46 GB, free: 1.66 MB / 1.17 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006508/0.5838, allocations: 2.474 MB / 1.462 GB, free: 15.19 MB / 1.186 GB
Notification: Performance of NFFlatten.flatten: time 0.004084/0.5879, allocations: 2.774 MB / 1.465 GB, free: 12.41 MB / 1.186 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001089/0.589, allocations: 0.6747 MB / 1.466 GB, free: 11.72 MB / 1.186 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001779/0.5908, allocations: 1.024 MB / 1.467 GB, free: 10.7 MB / 1.186 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002418/0.5932, allocations: 1.151 MB / 1.468 GB, free: 9.543 MB / 1.186 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002236/0.5934, allocations: 96 kB / 1.468 GB, free: 9.449 MB / 1.186 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.007451/0.6009, allocations: 3.118 MB / 1.471 GB, free: 6.324 MB / 1.186 GB
Notification: Performance of NFScalarize.scalarize: time 0.0007701/0.6017, allocations: 458.6 kB / 1.471 GB, free: 5.875 MB / 1.186 GB
Notification: Performance of NFVerifyModel.verify: time 0.000993/0.6026, allocations: 0.5794 MB / 1.472 GB, free: 5.293 MB / 1.186 GB
Notification: Performance of NFConvertDAE.convert: time 0.006502/0.6091, allocations: 2.971 MB / 1.475 GB, free: 2.312 MB / 1.186 GB
Notification: Performance of FrontEnd - DAE generated: time 4.95e-06/0.6092, allocations: 0 / 1.475 GB, free: 2.312 MB / 1.186 GB
Notification: Performance of FrontEnd: time 1.994e-06/0.6092, allocations: 0 / 1.475 GB, free: 2.312 MB / 1.186 GB
Notification: Performance of Transformations before backend: time 1.789e-05/0.6092, allocations: 0 / 1.475 GB, free: 2.312 MB / 1.186 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 173
 * Number of variables: 173
Notification: Performance of Generate backend data structure: time 0.003966/0.6131, allocations: 1.721 MB / 1.476 GB, free: 0.5352 MB / 1.186 GB
Notification: Performance of prepare preOptimizeDAE: time 5.286e-05/0.6132, allocations: 8.031 kB / 1.476 GB, free: 0.5273 MB / 1.186 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001944/0.6151, allocations: 307 kB / 1.477 GB, free: 232 kB / 1.186 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001489/0.6166, allocations: 0.828 MB / 1.478 GB, free: 15.36 MB / 1.201 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.668e-05/0.6167, allocations: 57.28 kB / 1.478 GB, free: 15.3 MB / 1.201 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001486/0.6168, allocations: 63.98 kB / 1.478 GB, free: 15.23 MB / 1.201 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001691/0.6185, allocations: 0.9883 MB / 1.479 GB, free: 14.23 MB / 1.201 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.25e-05/0.6186, allocations: 8 kB / 1.479 GB, free: 14.23 MB / 1.201 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.782e-05/0.6186, allocations: 23.98 kB / 1.479 GB, free: 14.2 MB / 1.201 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001129/0.6188, allocations: 77.89 kB / 1.479 GB, free: 14.12 MB / 1.201 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001739/0.6205, allocations: 1.011 MB / 1.48 GB, free: 13.11 MB / 1.201 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.006294/0.6268, allocations: 3.587 MB / 1.483 GB, free: 9.289 MB / 1.201 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001161/0.6279, allocations: 0.6302 MB / 1.484 GB, free: 8.652 MB / 1.201 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005749/0.6285, allocations: 365.2 kB / 1.484 GB, free: 8.297 MB / 1.201 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002842/0.6288, allocations: 190.8 kB / 1.484 GB, free: 8.074 MB / 1.201 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.079e-05/0.6288, allocations: 47.11 kB / 1.484 GB, free: 8.02 MB / 1.201 GB
Notification: Performance of pre-optimization done (n=62): time 4.308e-06/0.6289, allocations: 7.984 kB / 1.484 GB, free: 8.012 MB / 1.201 GB
Notification: Performance of matching and sorting (n=62): time 0.002064/0.6309, allocations: 1.022 MB / 1.485 GB, free: 6.988 MB / 1.201 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.522e-05/0.631, allocations: 111.4 kB / 1.486 GB, free: 6.852 MB / 1.201 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001129/0.6321, allocations: 0.8058 MB / 1.486 GB, free: 6.039 MB / 1.201 GB
Notification: Performance of collectPreVariables (initialization): time 7.942e-05/0.6322, allocations: 37.7 kB / 1.486 GB, free: 5.996 MB / 1.201 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003726/0.6326, allocations: 428.8 kB / 1.487 GB, free: 5.574 MB / 1.201 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002397/0.6328, allocations: 234 kB / 1.487 GB, free: 5.344 MB / 1.201 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002693/0.6331, allocations: 142.6 kB / 1.487 GB, free: 5.195 MB / 1.201 GB
Notification: Performance of setup shared object (initialization): time 0.0001718/0.6333, allocations: 337.9 kB / 1.487 GB, free: 4.859 MB / 1.201 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006221/0.6339, allocations: 348.6 kB / 1.488 GB, free: 4.516 MB / 1.201 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007143/0.6346, allocations: 460.8 kB / 1.488 GB, free: 4.031 MB / 1.201 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001252/0.6358, allocations: 0.7704 MB / 1.489 GB, free: 3.234 MB / 1.201 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.386e-06/0.6358, allocations: 4 kB / 1.489 GB, free: 3.23 MB / 1.201 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.001662/0.6375, allocations: 0.938 MB / 1.49 GB, free: 2.285 MB / 1.201 GB
Notification: Performance of prepare postOptimizeDAE: time 2.217e-05/0.6375, allocations: 12.03 kB / 1.49 GB, free: 2.273 MB / 1.201 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.706e-06/0.6375, allocations: 0 / 1.49 GB, free: 2.273 MB / 1.201 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.551e-05/0.6376, allocations: 8 kB / 1.49 GB, free: 2.266 MB / 1.201 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007395/0.6383, allocations: 143.8 kB / 1.49 GB, free: 2.125 MB / 1.201 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.219e-05/0.6383, allocations: 11.92 kB / 1.49 GB, free: 2.113 MB / 1.201 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008191/0.6391, allocations: 83.39 kB / 1.49 GB, free: 2.031 MB / 1.201 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.486e-05/0.6392, allocations: 24 kB / 1.49 GB, free: 2.008 MB / 1.201 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0009048/0.6401, allocations: 0.537 MB / 1.491 GB, free: 1.469 MB / 1.201 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0006855/0.6408, allocations: 450.5 kB / 1.491 GB, free: 0.9883 MB / 1.201 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001131/0.6419, allocations: 0.7331 MB / 1.492 GB, free: 220 kB / 1.201 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.174e-06/0.6419, allocations: 4 kB / 1.492 GB, free: 216 kB / 1.201 GB
Notification: Performance of matching and sorting (n=88) (initialization_lambda0): time 0.001563/0.6435, allocations: 0.8948 MB / 1.493 GB, free: 15.3 MB / 1.217 GB
Notification: Performance of prepare postOptimizeDAE: time 1.335e-05/0.6435, allocations: 8 kB / 1.493 GB, free: 15.3 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.376e-06/0.6435, allocations: 8 kB / 1.493 GB, free: 15.29 MB / 1.217 GB
Notification: Performance of postOpt tearingSystem (initialization): time 8.285e-06/0.6435, allocations: 4 kB / 1.493 GB, free: 15.29 MB / 1.217 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006838/0.6442, allocations: 147.8 kB / 1.493 GB, free: 15.14 MB / 1.217 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.533e-05/0.6442, allocations: 16.2 kB / 1.493 GB, free: 15.12 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007487/0.645, allocations: 63.64 kB / 1.493 GB, free: 15.06 MB / 1.217 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.601e-05/0.645, allocations: 28 kB / 1.493 GB, free: 15.04 MB / 1.217 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 10
 * 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.0002314/0.6453, allocations: 216.1 kB / 1.493 GB, free: 14.82 MB / 1.217 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001664/0.6454, allocations: 99.33 kB / 1.493 GB, free: 14.72 MB / 1.217 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001472/0.6469, allocations: 0.8112 MB / 1.494 GB, free: 13.9 MB / 1.217 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001119/0.648, allocations: 0.74 MB / 1.495 GB, free: 13.13 MB / 1.217 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.234e-06/0.648, allocations: 4 kB / 1.495 GB, free: 13.12 MB / 1.217 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003892/0.6484, allocations: 256.3 kB / 1.495 GB, free: 12.86 MB / 1.217 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001309/0.6486, allocations: 8 kB / 1.495 GB, free: 12.85 MB / 1.217 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005455/0.6491, allocations: 23.98 kB / 1.495 GB, free: 12.82 MB / 1.217 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.525e-05/0.6492, allocations: 40.45 kB / 1.495 GB, free: 12.79 MB / 1.217 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001603/0.6508, allocations: 0.8343 MB / 1.496 GB, free: 11.95 MB / 1.217 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.00198/0.6528, allocations: 1.353 MB / 1.497 GB, free: 10.58 MB / 1.217 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0005145/0.6533, allocations: 324.3 kB / 1.498 GB, free: 10.26 MB / 1.217 GB
Notification: Performance of sorting global known variables: time 0.0007584/0.654, allocations: 0.5614 MB / 1.498 GB, free: 9.707 MB / 1.217 GB
Notification: Performance of Backend: time 3.7e-07/0.654, allocations: 0 / 1.498 GB, free: 9.707 MB / 1.217 GB
Notification: Performance of simCode: created initialization part: time 0.004028/0.6581, allocations: 1.627 MB / 1.5 GB, free: 8.09 MB / 1.217 GB
Notification: Performance of SimCode: time 0.004226/0.6623, allocations: 2.434 MB / 1.502 GB, free: 5.609 MB / 1.217 GB
Notification: Performance of Templates: time 0.04913/0.7114, allocations: 29.95 MB / 1.531 GB, free: 7.883 MB / 1.248 GB
make -j1 -f Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.makefile
(rm -f Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; mkfifo Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; head -c 1048576 < Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe >> ../files/Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.sim & ./Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization  -abortSlowSimulation -alarm=400  -emit_protected -lv LOG_STATS > Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe 2>&1)
diffSimulationResults("Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_11.x/Buildings_Fluid_MixingVolumes_Validation_MixingVolumeInitialization.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_11_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches