Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/./OMCompiler/build/lib/omlibrary/ --ompython_omhome=/usr Buildings_6.0.0_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesAir.conf.json
Using package Buildings with version 6.0.0 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Buildings 6.0.0/package.mo)
Using package Modelica with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.2/package.mo)
Using package Complex with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.2.mo)
Using package ModelicaServices with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.2/package.mo)
Running command: translateModel(Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesAir,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_6.0.0_Buildings.Fluid.MixingVolumes.Validation.CoupledVolumesAir")
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.2/package.mo): time 0.004361/0.004361, allocations: 231.2 kB / 15.82 MB, free: 6.293 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.2.mo): time 0.001208/0.001207, allocations: 175.1 kB / 16.7 MB, free: 5.453 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.2/package.mo): time 3.963/3.963, allocations: 389.1 MB / 406.5 MB, free: 11.83 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Buildings 6.0.0/package.mo): time 4.026/4.026, allocations: 472.3 MB / 0.9024 GB, free: 9.223 MB / 0.5886 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004965/0.0004967, allocations: 12.22 kB / 1.008 GB, free: 138.2 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1754/0.1759, allocations: 98.72 MB / 1.105 GB, free: 42.07 MB / 0.6042 GB
Notification: Performance of FrontEnd - scodeFlatten: time 7.438/7.614, allocations: 2.426 GB / 3.531 GB, free: 83.08 MB / 0.823 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.000278/7.614, allocations: 96.11 kB / 3.531 GB, free: 83.03 MB / 0.823 GB
Notification: Performance of FrontEnd - DAE generated: time 2.634/10.25, allocations: 466.2 MB / 3.986 GB, free: 168.4 MB / 0.823 GB
Notification: Performance of FrontEnd: time 2.404e-06/10.25, allocations: 0 / 3.986 GB, free: 168.4 MB / 0.823 GB
Notification: Performance of Transformations before backend: time 9.264e-05/10.25, allocations: 24.84 kB / 3.986 GB, free: 168.4 MB / 0.823 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 152
 * Number of variables: 152
Notification: Performance of Generate backend data structure: time 0.003344/10.25, allocations: 1.213 MB / 3.987 GB, free: 167.7 MB / 0.823 GB
Notification: Performance of prepare preOptimizeDAE: time 4.536e-05/10.25, allocations: 8.969 kB / 3.987 GB, free: 167.7 MB / 0.823 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003004/10.26, allocations: 307 kB / 3.988 GB, free: 167.7 MB / 0.823 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.00226/10.26, allocations: 0.7603 MB / 3.988 GB, free: 167.4 MB / 0.823 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.721e-05/10.26, allocations: 51.3 kB / 3.989 GB, free: 167.4 MB / 0.823 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001558/10.26, allocations: 60.94 kB / 3.989 GB, free: 167.4 MB / 0.823 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001687/10.26, allocations: 0.6187 MB / 3.989 GB, free: 167.4 MB / 0.823 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.119e-05/10.26, allocations: 1 kB / 3.989 GB, free: 167.4 MB / 0.823 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001011/10.26, allocations: 29.03 kB / 3.989 GB, free: 167.4 MB / 0.823 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.011e-05/10.26, allocations: 23.91 kB / 3.989 GB, free: 167.4 MB / 0.823 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001392/10.26, allocations: 0.529 MB / 3.99 GB, free: 167.4 MB / 0.823 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.005414/10.27, allocations: 2.755 MB / 3.992 GB, free: 166 MB / 0.823 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001031/10.27, allocations: 451.8 kB / 3.993 GB, free: 166 MB / 0.823 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005298/10.27, allocations: 250.4 kB / 3.993 GB, free: 166 MB / 0.823 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002547/10.27, allocations: 97.92 kB / 3.993 GB, free: 165.9 MB / 0.823 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.109e-05/10.27, allocations: 47.44 kB / 3.993 GB, free: 165.8 MB / 0.823 GB
Notification: Performance of pre-optimization done (n=46): time 3.988e-06/10.27, allocations: 0 / 3.993 GB, free: 165.8 MB / 0.823 GB
Notification: Performance of matching and sorting (n=49): time 0.004753/10.27, allocations: 1.505 MB / 3.995 GB, free: 165.4 MB / 0.823 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.047e-05/10.27, allocations: 60.16 kB / 3.995 GB, free: 165.4 MB / 0.823 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009697/10.27, allocations: 0.5476 MB / 3.995 GB, free: 165.3 MB / 0.823 GB
Notification: Performance of collectPreVariables (initialization): time 9.03e-05/10.27, allocations: 38.64 kB / 3.995 GB, free: 165.2 MB / 0.823 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0002908/10.27, allocations: 359 kB / 3.996 GB, free: 165.1 MB / 0.823 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001928/10.27, allocations: 170 kB / 3.996 GB, free: 165 MB / 0.823 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 3.819e-05/10.27, allocations: 9.75 kB / 3.996 GB, free: 165 MB / 0.823 GB
Notification: Performance of setup shared object (initialization): time 0.0001227/10.27, allocations: 376.2 kB / 3.996 GB, free: 164.7 MB / 0.823 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004417/10.28, allocations: 177.7 kB / 3.996 GB, free: 164.7 MB / 0.823 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005506/10.28, allocations: 298.9 kB / 3.997 GB, free: 164.6 MB / 0.823 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: vol.dynBal.medium.p = vol.dynBal.p_start (vol1.dynBal.p_start = vol.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.003407/10.28, allocations: 0.7632 MB / 3.997 GB, free: 164.5 MB / 0.823 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.518e-06/10.28, allocations: 1.375 kB / 3.997 GB, free: 164.5 MB / 0.823 GB
Notification: Performance of matching and sorting (n=60) (initialization): time 0.00151/10.28, allocations: 0.5851 MB / 3.998 GB, free: 164.4 MB / 0.823 GB
Notification: Performance of prepare postOptimizeDAE: time 7.298e-05/10.28, allocations: 143.4 kB / 3.998 GB, free: 164.3 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.556e-06/10.28, allocations: 0.7188 kB / 3.998 GB, free: 164.3 MB / 0.823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0002259/10.28, allocations: 42.84 kB / 3.998 GB, free: 164.3 MB / 0.823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001096/10.28, allocations: 113.8 kB / 3.998 GB, free: 164.3 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001709/10.28, allocations: 2.107 MB / 4 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001507/10.29, allocations: 57.75 kB / 4 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.747e-05/10.29, allocations: 20.06 kB / 4 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of prepare postOptimizeDAE: time 1.078e-05/10.29, allocations: 3.531 kB / 4 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001346/10.29, allocations: 0.5067 MB / 4.001 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.983e-06/10.29, allocations: 6.781 kB / 4.001 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000182/10.29, allocations: 34.36 kB / 4.001 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007555/10.29, allocations: 98.31 kB / 4.001 GB, free: 162.3 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001381/10.29, allocations: 1.515 MB / 4.003 GB, free: 161 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001546/10.29, allocations: 49.97 kB / 4.003 GB, free: 161 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.577e-05/10.29, allocations: 27.06 kB / 4.003 GB, free: 161 MB / 0.823 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization sytem:
         vol.dynBal.medium.p = vol.dynBal.p_start.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 8
 * 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 (57):
 * Single equations (assignments): 55
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(1,100.0%) 3}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0007389/10.29, allocations: 336.4 kB / 4.003 GB, free: 160.8 MB / 0.823 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002226/10.29, allocations: 70.72 kB / 4.003 GB, free: 160.7 MB / 0.823 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001494/10.29, allocations: 0.5571 MB / 4.004 GB, free: 160.7 MB / 0.823 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.147e-05/10.29, allocations: 5.344 kB / 4.004 GB, free: 160.7 MB / 0.823 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.815e-06/10.29, allocations: 4.453 kB / 4.004 GB, free: 160.7 MB / 0.823 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001188/10.29, allocations: 0.7855 MB / 4.004 GB, free: 160.2 MB / 0.823 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003917/10.3, allocations: 1.565 MB / 4.006 GB, free: 159.8 MB / 0.823 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.385e-06/10.3, allocations: 7.656 kB / 4.006 GB, free: 159.8 MB / 0.823 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001171/10.3, allocations: 122.5 kB / 4.006 GB, free: 159.8 MB / 0.823 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0001895/10.3, allocations: 36.25 kB / 4.006 GB, free: 159.8 MB / 0.823 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.099e-05/10.3, allocations: 12.75 kB / 4.006 GB, free: 159.8 MB / 0.823 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.00138/10.3, allocations: 1.942 MB / 4.008 GB, free: 158 MB / 0.823 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.176e-06/10.3, allocations: 1.562 kB / 4.008 GB, free: 158 MB / 0.823 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002189/10.3, allocations: 0.9317 MB / 4.009 GB, free: 157.8 MB / 0.823 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006389/10.3, allocations: 206.5 kB / 4.009 GB, free: 157.6 MB / 0.823 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001664/10.3, allocations: 13.34 kB / 4.009 GB, free: 157.6 MB / 0.823 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001131/10.31, allocations: 55.97 kB / 4.009 GB, free: 157.6 MB / 0.823 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 9.811e-05/10.31, allocations: 34 kB / 4.009 GB, free: 157.6 MB / 0.823 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.231e-05/10.31, allocations: 21.25 kB / 4.009 GB, free: 157.6 MB / 0.823 GB
Notification: Performance of sorting global known variables: time 0.0007585/10.31, allocations: 390.5 kB / 4.009 GB, free: 157.5 MB / 0.823 GB
Notification: Performance of sort global known variables: time 6.11e-07/10.31, allocations: 2.906 kB / 4.009 GB, free: 157.5 MB / 0.823 GB
Notification: Performance of remove unused functions: time 0.002536/10.31, allocations: 497.8 kB / 4.01 GB, free: 157.5 MB / 0.823 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 5 (vol.dynBal.U,vol.dynBal.mXi[1],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 (47):
 * Single equations (assignments): 45
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(1,100.0%) 2}
 * Non-linear torn systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.002632/10.31, allocations: 1.231 MB / 4.011 GB, free: 157.2 MB / 0.823 GB
Notification: Performance of simCode: created initialization part: time 0.002654/10.31, allocations: 0.9971 MB / 4.012 GB, free: 157 MB / 0.823 GB
Notification: Performance of simCode: created event and clocks part: time 6.823e-06/10.31, allocations: 4.438 kB / 4.012 GB, free: 157 MB / 0.823 GB
Notification: Performance of simCode: created simulation system equations: time 0.0007354/10.32, allocations: 369.4 kB / 4.013 GB, free: 156.9 MB / 0.823 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003911/10.32, allocations: 470.5 kB / 4.013 GB, free: 156.9 MB / 0.823 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003524/10.32, allocations: 2.003 MB / 4.015 GB, free: 156 MB / 0.823 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006018/10.32, allocations: 1.025 MB / 4.016 GB, free: 155.3 MB / 0.823 GB
Notification: Performance of simCode: alias equations: time 0.001512/10.33, allocations: 217.8 kB / 4.016 GB, free: 155.3 MB / 0.823 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002614/10.33, allocations: 60.25 kB / 4.016 GB, free: 155.3 MB / 0.823 GB
Notification: Performance of SimCode: time 1.062e-06/10.33, allocations: 0 / 4.016 GB, free: 155.3 MB / 0.823 GB
Notification: Performance of Templates: time 0.06563/10.39, allocations: 29.39 MB / 4.045 GB, free: 154.3 MB / 0.823 GB