Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_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 10.1.1-maint.10.0.x/package.mo", uses=false)
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.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_10_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_10_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.001442/0.001442, allocations: 108.1 kB / 16.41 MB, free: 6.5 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.001612/0.001612, allocations: 186.7 kB / 17.35 MB, free: 5.723 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.313/1.313, allocations: 222.9 MB / 241.1 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.406/2.406, allocations: 437 MB / 0.7112 GB, free: 4.391 MB / 0.5762 GB
Notification: Performance of FrontEnd - loaded program: time 0.001344/0.001344, allocations: 63.91 kB / 1.019 GB, free: 9.406 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7236/0.7249, allocations: 151.6 MB / 1.167 GB, free: 3.832 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization): time 0.1914/0.9164, allocations: 187.9 MB / 1.351 GB, free: 7.254 MB / 1.076 GB
Notification: Performance of NFInst.instExpressions: time 0.01498/0.9314, allocations: 10.76 MB / 1.361 GB, free: 12.46 MB / 1.092 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001334/0.9328, allocations: 39.75 kB / 1.361 GB, free: 12.42 MB / 1.092 GB
Notification: Performance of NFTyping.typeComponents: time 0.001304/0.9342, allocations: 0.501 MB / 1.362 GB, free: 11.92 MB / 1.092 GB
Notification: Performance of NFTyping.typeBindings: time 0.006671/0.9409, allocations: 2.661 MB / 1.364 GB, free: 9.246 MB / 1.092 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006315/0.9472, allocations: 2.471 MB / 1.367 GB, free: 6.781 MB / 1.092 GB
Notification: Performance of NFFlatten.flatten: time 0.004391/0.9516, allocations: 2.778 MB / 1.37 GB, free: 3.992 MB / 1.092 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001301/0.9529, allocations: 0.7799 MB / 1.37 GB, free: 3.195 MB / 1.092 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001927/0.9549, allocations: 1.035 MB / 1.371 GB, free: 2.156 MB / 1.092 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002325/0.9572, allocations: 1.048 MB / 1.372 GB, free: 1.109 MB / 1.092 GB
Notification: Performance of NFPackage.collectConstants: time 0.0002263/0.9574, allocations: 100 kB / 1.372 GB, free: 1.012 MB / 1.092 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006616/0.9641, allocations: 3.009 MB / 1.375 GB, free: 14 MB / 1.107 GB
Notification: Performance of NFScalarize.scalarize: time 0.0007084/0.9648, allocations: 438.8 kB / 1.376 GB, free: 13.57 MB / 1.107 GB
Notification: Performance of NFVerifyModel.verify: time 0.0008896/0.9657, allocations: 0.5832 MB / 1.376 GB, free: 12.98 MB / 1.107 GB
Notification: Performance of NFConvertDAE.convert: time 0.006036/0.9718, allocations: 2.957 MB / 1.379 GB, free: 10.02 MB / 1.107 GB
Notification: Performance of FrontEnd - DAE generated: time 5.289e-06/0.9718, allocations: 4 kB / 1.379 GB, free: 10.01 MB / 1.107 GB
Notification: Performance of FrontEnd: time 2.294e-06/0.9718, allocations: 0 / 1.379 GB, free: 10.01 MB / 1.107 GB
Notification: Performance of Transformations before backend: time 1.813e-05/0.9718, allocations: 0 / 1.379 GB, free: 10.01 MB / 1.107 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.0037/0.9755, allocations: 1.67 MB / 1.381 GB, free: 8.289 MB / 1.107 GB
Notification: Performance of prepare preOptimizeDAE: time 5.12e-05/0.9756, allocations: 16.88 kB / 1.381 GB, free: 8.273 MB / 1.107 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001981/0.9776, allocations: 298.3 kB / 1.381 GB, free: 7.98 MB / 1.107 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001548/0.9792, allocations: 0.8195 MB / 1.382 GB, free: 7.117 MB / 1.107 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 6.412e-05/0.9792, allocations: 57.27 kB / 1.382 GB, free: 7.059 MB / 1.107 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.000133/0.9794, allocations: 67.98 kB / 1.382 GB, free: 6.992 MB / 1.107 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001688/0.9811, allocations: 0.996 MB / 1.383 GB, free: 5.98 MB / 1.107 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.188e-05/0.9811, allocations: 0 / 1.383 GB, free: 5.98 MB / 1.107 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.319e-05/0.9812, allocations: 27.98 kB / 1.383 GB, free: 5.953 MB / 1.107 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001076/0.9813, allocations: 73.95 kB / 1.383 GB, free: 5.879 MB / 1.107 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001679/0.983, allocations: 1.011 MB / 1.384 GB, free: 4.871 MB / 1.107 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.006562/0.9896, allocations: 3.574 MB / 1.388 GB, free: 1.062 MB / 1.107 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001166/0.9908, allocations: 0.6614 MB / 1.388 GB, free: 400 kB / 1.107 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005471/0.9913, allocations: 382.3 kB / 1.389 GB, free: 16 kB / 1.107 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002879/0.9916, allocations: 190.8 kB / 1.389 GB, free: 15.79 MB / 1.123 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.947e-05/0.9917, allocations: 43.05 kB / 1.389 GB, free: 15.74 MB / 1.123 GB
Notification: Performance of pre-optimization done (n=62): time 2.735e-06/0.9917, allocations: 4 kB / 1.389 GB, free: 15.74 MB / 1.123 GB
Notification: Performance of matching and sorting (n=62): time 0.002057/0.9937, allocations: 1.021 MB / 1.39 GB, free: 14.71 MB / 1.123 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.908e-05/0.9938, allocations: 111.4 kB / 1.39 GB, free: 14.58 MB / 1.123 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001162/0.995, allocations: 0.8018 MB / 1.391 GB, free: 13.77 MB / 1.123 GB
Notification: Performance of collectPreVariables (initialization): time 7.356e-05/0.9951, allocations: 41.7 kB / 1.391 GB, free: 13.72 MB / 1.123 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003761/0.9955, allocations: 432 kB / 1.391 GB, free: 13.3 MB / 1.123 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000255/0.9957, allocations: 220.8 kB / 1.391 GB, free: 13.08 MB / 1.123 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0003385/0.9961, allocations: 146.6 kB / 1.392 GB, free: 12.93 MB / 1.123 GB
Notification: Performance of setup shared object (initialization): time 0.0001453/0.9962, allocations: 333.9 kB / 1.392 GB, free: 12.6 MB / 1.123 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00061/0.9968, allocations: 344.7 kB / 1.392 GB, free: 12.26 MB / 1.123 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006738/0.9975, allocations: 472.6 kB / 1.393 GB, free: 11.76 MB / 1.123 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001164/0.9987, allocations: 0.7665 MB / 1.393 GB, free: 10.96 MB / 1.123 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.648e-06/0.9987, allocations: 0 / 1.393 GB, free: 10.96 MB / 1.123 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.001836/1.001, allocations: 0.9256 MB / 1.394 GB, free: 10.03 MB / 1.123 GB
Notification: Performance of prepare postOptimizeDAE: time 2.215e-05/1.001, allocations: 8.281 kB / 1.394 GB, free: 10.02 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.033e-05/1.001, allocations: 8 kB / 1.394 GB, free: 10.01 MB / 1.123 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.122e-05/1.001, allocations: 4 kB / 1.394 GB, free: 10.01 MB / 1.123 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008297/1.001, allocations: 147.8 kB / 1.394 GB, free: 9.863 MB / 1.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.259e-05/1.002, allocations: 11.98 kB / 1.394 GB, free: 9.852 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008305/1.002, allocations: 79.11 kB / 1.395 GB, free: 9.773 MB / 1.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.81e-05/1.002, allocations: 28 kB / 1.395 GB, free: 9.746 MB / 1.123 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0008502/1.003, allocations: 0.537 MB / 1.395 GB, free: 9.203 MB / 1.123 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0006484/1.004, allocations: 454.4 kB / 1.396 GB, free: 8.719 MB / 1.123 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001079/1.005, allocations: 0.7253 MB / 1.396 GB, free: 7.953 MB / 1.123 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 7.344e-06/1.005, allocations: 11.97 kB / 1.396 GB, free: 7.941 MB / 1.123 GB
Notification: Performance of matching and sorting (n=88) (initialization_lambda0): time 0.001495/1.007, allocations: 0.8904 MB / 1.397 GB, free: 7.043 MB / 1.123 GB
Notification: Performance of prepare postOptimizeDAE: time 1.292e-05/1.007, allocations: 4 kB / 1.397 GB, free: 7.039 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.141e-06/1.007, allocations: 4 kB / 1.397 GB, free: 7.035 MB / 1.123 GB
Notification: Performance of postOpt tearingSystem (initialization): time 9.007e-06/1.007, allocations: 4 kB / 1.397 GB, free: 7.031 MB / 1.123 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006716/1.007, allocations: 147.8 kB / 1.397 GB, free: 6.887 MB / 1.123 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.28e-05/1.007, allocations: 8 kB / 1.397 GB, free: 6.879 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008089/1.008, allocations: 71.69 kB / 1.397 GB, free: 6.809 MB / 1.123 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.484e-05/1.008, allocations: 28 kB / 1.397 GB, free: 6.781 MB / 1.123 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.0002343/1.008, allocations: 216.1 kB / 1.398 GB, free: 6.562 MB / 1.123 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000217/1.009, allocations: 94.81 kB / 1.398 GB, free: 6.469 MB / 1.123 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00148/1.01, allocations: 0.8115 MB / 1.398 GB, free: 5.652 MB / 1.123 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00103/1.011, allocations: 0.74 MB / 1.399 GB, free: 4.883 MB / 1.123 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.895e-06/1.011, allocations: 0 / 1.399 GB, free: 4.883 MB / 1.123 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004589/1.012, allocations: 255.8 kB / 1.399 GB, free: 4.613 MB / 1.123 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001617/1.012, allocations: 12 kB / 1.399 GB, free: 4.602 MB / 1.123 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005572/1.012, allocations: 21.2 kB / 1.399 GB, free: 4.582 MB / 1.123 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.854e-05/1.013, allocations: 32.52 kB / 1.4 GB, free: 4.551 MB / 1.123 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.00154/1.014, allocations: 0.8383 MB / 1.4 GB, free: 3.703 MB / 1.123 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.001785/1.016, allocations: 1.348 MB / 1.402 GB, free: 2.34 MB / 1.123 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0004862/1.016, allocations: 348.5 kB / 1.402 GB, free: 1.996 MB / 1.123 GB
Notification: Performance of sorting global known variables: time 0.0007563/1.017, allocations: 0.5576 MB / 1.403 GB, free: 1.445 MB / 1.123 GB
Notification: Performance of Backend: time 3.7e-07/1.017, allocations: 0 / 1.403 GB, free: 1.445 MB / 1.123 GB
Notification: Performance of simCode: created initialization part: time 0.004142/1.021, allocations: 1.698 MB / 1.404 GB, free: 15.76 MB / 1.139 GB
Notification: Performance of SimCode: time 0.004175/1.025, allocations: 2.396 MB / 1.407 GB, free: 13.32 MB / 1.139 GB
Notification: Performance of Templates: time 0.04518/1.071, allocations: 29.52 MB / 1.435 GB, free: 12 kB / 1.154 GB
make -j1 -f Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.makefile
(rm -f Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; mkfifo Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; head -c 1048576 < Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe >> ../files/Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.sim & ./Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe 2>&1)
diffSimulationResults("Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_10.0.x/Buildings_Fluid_MixingVolumes_Validation_MixingVolumeInitialization.csv","/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/Buildings_10_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches