Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_maint.7.0.x_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 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo", uses=false)
Using package Buildings with version 7.0.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization")
translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_maint.7.0.x_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.0008713/0.0008713, allocations: 98.03 kB / 15.36 MB, free: 0.7344 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.006003/0.006003, allocations: 171.3 kB / 16.27 MB, free: 6.656 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.627/1.627, allocations: 205.4 MB / 222.4 MB, free: 5.57 MB / 174.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 7.0.3-maint.7.0.x/package.mo): time 1.746/1.746, allocations: 252 MB / 0.5105 GB, free: 4.703 MB / 414.1 MB
Notification: Modelica requested package Complex of version 3.2.3. Complex 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Modelica requested package ModelicaServices of version 3.2.3. ModelicaServices 4.0.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.0005316/0.0005318, allocations: 16.61 kB / 0.6249 GB, free: 0.7578 MB / 0.5137 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.5637/0.5642, allocations: 106.3 MB / 0.7287 GB, free: 11.54 MB / 0.545 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization): time 0.2094/0.7737, allocations: 183.9 MB / 0.9084 GB, free: 2.91 MB / 0.7169 GB
Notification: Performance of NFInst.instExpressions: time 0.6383/1.412, allocations: 11.05 MB / 0.9191 GB, free: 1.969 MB / 0.7169 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002375/1.414, allocations: 42.78 kB / 0.9192 GB, free: 1.969 MB / 0.7169 GB
Notification: Performance of NFTyping.typeComponents: time 0.00226/1.417, allocations: 427.5 kB / 0.9196 GB, free: 1.961 MB / 0.7169 GB
Notification: Performance of NFTyping.typeBindings: time 0.01029/1.427, allocations: 2.423 MB / 0.922 GB, free: 1.84 MB / 0.7169 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008777/1.436, allocations: 2.1 MB / 0.924 GB, free: 1.77 MB / 0.7169 GB
Notification: Performance of NFFlatten.flatten: time 0.007396/1.443, allocations: 4.045 MB / 0.928 GB, free: 1.77 MB / 0.7169 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001939/1.445, allocations: 0.6615 MB / 0.9286 GB, free: 1.707 MB / 0.7169 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.004253/1.45, allocations: 0.8531 MB / 0.9294 GB, free: 1.703 MB / 0.7169 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.003694/1.453, allocations: 1.066 MB / 0.9305 GB, free: 1.695 MB / 0.7169 GB
Notification: Performance of NFPackage.collectConstants: time 0.0004545/1.454, allocations: 45.28 kB / 0.9305 GB, free: 1.695 MB / 0.7169 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01008/1.464, allocations: 3.291 MB / 0.9337 GB, free: 1.668 MB / 0.7169 GB
Notification: Performance of NFScalarize.scalarize: time 0.001124/1.465, allocations: 391.7 kB / 0.9341 GB, free: 1.668 MB / 0.7169 GB
Notification: Performance of NFVerifyModel.verify: time 0.002239/1.467, allocations: 0.5542 MB / 0.9347 GB, free: 17.64 MB / 0.7325 GB
Notification: Performance of NFConvertDAE.convert: time 0.009742/1.477, allocations: 3.018 MB / 0.9376 GB, free: 17.47 MB / 0.7325 GB
Notification: Performance of FrontEnd - DAE generated: time 5.42e-06/1.477, allocations: 0 / 0.9376 GB, free: 17.47 MB / 0.7325 GB
Notification: Performance of FrontEnd: time 3.086e-06/1.477, allocations: 0 / 0.9376 GB, free: 17.47 MB / 0.7325 GB
Notification: Performance of Transformations before backend: time 7.883e-05/1.477, allocations: 2.969 kB / 0.9376 GB, free: 17.47 MB / 0.7325 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 175
 * Number of variables: 175
Notification: Performance of Generate backend data structure: time 0.00506/1.482, allocations: 1.471 MB / 0.939 GB, free: 16.61 MB / 0.7325 GB
Notification: Performance of prepare preOptimizeDAE: time 5.276e-05/1.482, allocations: 8.031 kB / 0.9391 GB, free: 16.61 MB / 0.7325 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002253/1.484, allocations: 302 kB / 0.9393 GB, free: 16.55 MB / 0.7325 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002184/1.487, allocations: 0.779 MB / 0.9401 GB, free: 16.23 MB / 0.7325 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.984e-05/1.487, allocations: 53.44 kB / 0.9401 GB, free: 16.23 MB / 0.7325 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002765/1.487, allocations: 67.69 kB / 0.9402 GB, free: 16.22 MB / 0.7325 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002259/1.489, allocations: 1.002 MB / 0.9412 GB, free: 16.14 MB / 0.7325 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.44e-05/1.489, allocations: 0 / 0.9412 GB, free: 16.14 MB / 0.7325 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001091/1.49, allocations: 28.39 kB / 0.9412 GB, free: 16.14 MB / 0.7325 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001217/1.49, allocations: 78.31 kB / 0.9413 GB, free: 16.14 MB / 0.7325 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001877/1.492, allocations: 1.01 MB / 0.9423 GB, free: 16.13 MB / 0.7325 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.006844/1.498, allocations: 3.602 MB / 0.9458 GB, free: 14.78 MB / 0.7325 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009945/1.499, allocations: 0.6469 MB / 0.9464 GB, free: 14.75 MB / 0.7325 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005119/1.5, allocations: 371 kB / 0.9468 GB, free: 14.74 MB / 0.7325 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002668/1.5, allocations: 196.8 kB / 0.947 GB, free: 14.55 MB / 0.7325 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.854e-05/1.5, allocations: 44.72 kB / 0.947 GB, free: 14.52 MB / 0.7325 GB
Notification: Performance of pre-optimization done (n=62): time 2.886e-06/1.5, allocations: 0 / 0.947 GB, free: 14.52 MB / 0.7325 GB
Notification: Performance of matching and sorting (n=62): time 0.002119/1.502, allocations: 1.021 MB / 0.948 GB, free: 14.42 MB / 0.7325 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.223e-05/1.503, allocations: 110.1 kB / 0.9481 GB, free: 14.29 MB / 0.7325 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001257/1.504, allocations: 0.7981 MB / 0.9489 GB, free: 14.16 MB / 0.7325 GB
Notification: Performance of collectPreVariables (initialization): time 9.804e-05/1.504, allocations: 38.14 kB / 0.9489 GB, free: 14.13 MB / 0.7325 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0004196/1.504, allocations: 426.4 kB / 0.9493 GB, free: 13.96 MB / 0.7325 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002646/1.505, allocations: 224.9 kB / 0.9496 GB, free: 13.82 MB / 0.7325 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.000135/1.505, allocations: 66 kB / 0.9496 GB, free: 13.8 MB / 0.7325 GB
Notification: Performance of setup shared object (initialization): time 0.0001812/1.505, allocations: 343.8 kB / 0.9499 GB, free: 13.49 MB / 0.7325 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005375/1.505, allocations: 331.6 kB / 0.9503 GB, free: 13.49 MB / 0.7325 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006486/1.506, allocations: 467.2 kB / 0.9507 GB, free: 13.38 MB / 0.7325 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001163/1.507, allocations: 0.7671 MB / 0.9515 GB, free: 13.29 MB / 0.7325 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.853e-06/1.507, allocations: 2.906 kB / 0.9515 GB, free: 13.29 MB / 0.7325 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.001655/1.509, allocations: 0.9217 MB / 0.9524 GB, free: 13.2 MB / 0.7325 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001516/1.509, allocations: 155.4 kB / 0.9525 GB, free: 13.03 MB / 0.7325 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.076e-05/1.509, allocations: 6.906 kB / 0.9525 GB, free: 13.03 MB / 0.7325 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.707e-05/1.509, allocations: 3.312 kB / 0.9525 GB, free: 13.03 MB / 0.7325 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007175/1.51, allocations: 153.8 kB / 0.9527 GB, free: 13.02 MB / 0.7325 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.411e-05/1.51, allocations: 5.969 kB / 0.9527 GB, free: 13.02 MB / 0.7325 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001136/1.511, allocations: 111.1 kB / 0.9528 GB, free: 12.98 MB / 0.7325 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.951e-05/1.511, allocations: 32.94 kB / 0.9528 GB, free: 12.98 MB / 0.7325 GB
Notification: Performance of prepare postOptimizeDAE: time 1.574e-05/1.511, allocations: 5.469 kB / 0.9528 GB, free: 12.98 MB / 0.7325 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001564/1.513, allocations: 0.769 MB / 0.9536 GB, free: 12.96 MB / 0.7325 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.42e-05/1.513, allocations: 2.031 kB / 0.9536 GB, free: 12.96 MB / 0.7325 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.877e-05/1.513, allocations: 9.125 kB / 0.9536 GB, free: 12.96 MB / 0.7325 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007081/1.514, allocations: 143.4 kB / 0.9537 GB, free: 12.96 MB / 0.7325 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.54e-05/1.514, allocations: 6.781 kB / 0.9537 GB, free: 12.96 MB / 0.7325 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001184/1.515, allocations: 97.88 kB / 0.9538 GB, free: 12.92 MB / 0.7325 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.695e-05/1.515, allocations: 28.12 kB / 0.9538 GB, free: 12.92 MB / 0.7325 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.000841/1.516, allocations: 378.8 kB / 0.9542 GB, free: 12.72 MB / 0.7325 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003195/1.516, allocations: 96.94 kB / 0.9543 GB, free: 12.68 MB / 0.7325 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001804/1.518, allocations: 0.794 MB / 0.9551 GB, free: 12.62 MB / 0.7325 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.178e-05/1.518, allocations: 4.969 kB / 0.9551 GB, free: 12.62 MB / 0.7325 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.112e-05/1.518, allocations: 4.516 kB / 0.9551 GB, free: 12.62 MB / 0.7325 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001247/1.519, allocations: 0.7413 MB / 0.9558 GB, free: 12.45 MB / 0.7325 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004563/1.524, allocations: 2.089 MB / 0.9578 GB, free: 12 MB / 0.7325 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.443e-05/1.524, allocations: 7.484 kB / 0.9578 GB, free: 12 MB / 0.7325 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006304/1.524, allocations: 134.5 kB / 0.958 GB, free: 12 MB / 0.7325 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.489e-05/1.524, allocations: 9.188 kB / 0.958 GB, free: 11.99 MB / 0.7325 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.587e-05/1.525, allocations: 21.06 kB / 0.958 GB, free: 11.99 MB / 0.7325 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.445e-05/1.525, allocations: 9.422 kB / 0.958 GB, free: 11.99 MB / 0.7325 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.434e-06/1.525, allocations: 6.156 kB / 0.958 GB, free: 11.99 MB / 0.7325 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002126/1.527, allocations: 1.389 MB / 0.9594 GB, free: 11.67 MB / 0.7325 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006269/1.527, allocations: 265.2 kB / 0.9596 GB, free: 11.52 MB / 0.7325 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002248/1.528, allocations: 16.84 kB / 0.9596 GB, free: 11.52 MB / 0.7325 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008226/1.528, allocations: 55.95 kB / 0.9597 GB, free: 11.51 MB / 0.7325 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.226e-05/1.529, allocations: 46.44 kB / 0.9597 GB, free: 11.5 MB / 0.7325 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.409e-05/1.529, allocations: 23.91 kB / 0.9598 GB, free: 11.5 MB / 0.7325 GB
Notification: Performance of sorting global known variables: time 0.0008212/1.529, allocations: 0.5631 MB / 0.9603 GB, free: 11.41 MB / 0.7325 GB
Notification: Performance of sort global known variables: time 1.6e-07/1.529, allocations: 0 / 0.9603 GB, free: 11.41 MB / 0.7325 GB
Notification: Performance of remove unused functions: time 0.002353/1.532, allocations: 0.7497 MB / 0.961 GB, free: 11.29 MB / 0.7325 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 15
 * Number of states: 3 (vol1.dynBal.U,vol1.dynBal.m,vol1.dynBal.mXi[1])
 * 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 (64):
 * Single equations (assignments): 64
 * 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.002121/1.534, allocations: 0.5497 MB / 0.9616 GB, free: 11.1 MB / 0.7325 GB
Notification: Performance of simCode: created initialization part: time 0.00222/1.536, allocations: 1.164 MB / 0.9627 GB, free: 11.08 MB / 0.7325 GB
Notification: Performance of simCode: created event and clocks part: time 6.512e-06/1.536, allocations: 1.859 kB / 0.9627 GB, free: 11.08 MB / 0.7325 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005944/1.537, allocations: 370.6 kB / 0.9631 GB, free: 11.08 MB / 0.7325 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003246/1.54, allocations: 0.5079 MB / 0.9636 GB, free: 11.04 MB / 0.7325 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004307/1.544, allocations: 2.325 MB / 0.9658 GB, free: 9.836 MB / 0.7325 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00114/1.546, allocations: 1.077 MB / 0.9669 GB, free: 9.125 MB / 0.7325 GB
Notification: Performance of simCode: alias equations: time 0.0017/1.547, allocations: 419.9 kB / 0.9673 GB, free: 9.059 MB / 0.7325 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003184/1.548, allocations: 79.34 kB / 0.9674 GB, free: 9.051 MB / 0.7325 GB
Notification: Performance of SimCode: time 9.51e-07/1.548, allocations: 2.906 kB / 0.9674 GB, free: 9.051 MB / 0.7325 GB
Notification: Performance of Templates: time 0.04444/1.592, allocations: 22.1 MB / 0.989 GB, free: 13.83 MB / 0.7481 GB
make -j1 -f Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.makefile
Environment - environmentSimulation:
(rm -f Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; mkfifo Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; head -c 1048576 < Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe >> ../files/Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.sim & ./Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_maint.7.0.x_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe 2>&1)
Environment - environmentSimulation: