Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_master_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 9.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo)
Running command: translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_master_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 4.83/4.83, allocations: 0.5623 GB / 0.5776 GB, free: 3.332 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.00243/0.00243, allocations: 363.3 kB / 0.6447 GB, free: 185.7 MB / 474.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.186/4.186, allocations: 410.7 MB / 1.113 GB, free: 6.051 MB / 0.6042 GB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001857/0.001857, allocations: 179 kB / 1.226 GB, free: 6.219 MB / 0.7136 GB
Notification: Performance of FrontEnd - loaded program: time 0.0005011/0.0005014, allocations: 12 kB / 1.349 GB, free: 8.355 MB / 0.8386 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.6971/0.6976, allocations: 115.3 MB / 1.461 GB, free: 284.4 MB / 0.8542 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlowPrescribedHeatFlowRate): time 0.2022/0.8998, allocations: 171.3 MB / 1.629 GB, free: 113.1 MB / 0.8542 GB
Notification: Performance of NFInst.instExpressions: time 0.01143/0.9113, allocations: 5.871 MB / 1.634 GB, free: 107.2 MB / 0.8542 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001474/0.9128, allocations: 27.81 kB / 1.634 GB, free: 107.2 MB / 0.8542 GB
Notification: Performance of NFTyping.typeComponents: time 0.002148/0.915, allocations: 0.5125 MB / 1.635 GB, free: 106.7 MB / 0.8542 GB
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:788:36-789:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:786:36-787:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:788:36-789:54:writable] Warning: 'each' used when modifying non-array element m_flow.
[/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/Fluid/Sources.mo:786:36-787:54:writable] Warning: 'each' used when modifying non-array element m_flow.
Notification: Performance of NFTyping.typeBindings: time 0.006276/0.9213, allocations: 1.803 MB / 1.637 GB, free: 104.9 MB / 0.8542 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004811/0.9262, allocations: 1.17 MB / 1.638 GB, free: 103.8 MB / 0.8542 GB
Notification: Performance of NFFlatten.flatten: time 0.004342/0.9305, allocations: 2.975 MB / 1.641 GB, free: 100.8 MB / 0.8542 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001426/0.932, allocations: 0.6528 MB / 1.641 GB, free: 100.1 MB / 0.8542 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002181/0.9342, allocations: 0.809 MB / 1.642 GB, free: 99.31 MB / 0.8542 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001748/0.936, allocations: 0.7626 MB / 1.643 GB, free: 98.55 MB / 0.8542 GB
Notification: Performance of NFPackage.collectConstants: time 0.000245/0.9363, allocations: 40 kB / 1.643 GB, free: 98.51 MB / 0.8542 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002914/0.9392, allocations: 0.8338 MB / 1.644 GB, free: 97.67 MB / 0.8542 GB
Notification: Performance of NFScalarize.scalarize: time 0.0006026/0.9399, allocations: 343 kB / 1.644 GB, free: 97.34 MB / 0.8542 GB
Notification: Performance of NFVerifyModel.verify: time 0.0004232/0.9403, allocations: 233.1 kB / 1.644 GB, free: 97.1 MB / 0.8542 GB
Notification: Performance of NFConvertDAE.convert: time 0.002509/0.9428, allocations: 1.368 MB / 1.646 GB, free: 95.73 MB / 0.8542 GB
Notification: Performance of FrontEnd - DAE generated: time 6.713e-06/0.9429, allocations: 0 / 1.646 GB, free: 95.73 MB / 0.8542 GB
Notification: Performance of FrontEnd: time 2.324e-06/0.9429, allocations: 4 kB / 1.646 GB, free: 95.73 MB / 0.8542 GB
Notification: Performance of Transformations before backend: time 3.158e-05/0.943, allocations: 0 / 1.646 GB, free: 95.73 MB / 0.8542 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 187
 * Number of variables: 187
Notification: Performance of Generate backend data structure: time 0.002975/0.9459, allocations: 1.223 MB / 1.647 GB, free: 94.45 MB / 0.8542 GB
Notification: Performance of prepare preOptimizeDAE: time 4.595e-05/0.946, allocations: 15.62 kB / 1.647 GB, free: 94.44 MB / 0.8542 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00421/0.9502, allocations: 434.3 kB / 1.647 GB, free: 94.02 MB / 0.8542 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002123/0.9524, allocations: 0.7342 MB / 1.648 GB, free: 93.24 MB / 0.8542 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000611/0.9531, allocations: 131.9 kB / 1.648 GB, free: 93.12 MB / 0.8542 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002102/0.9533, allocations: 72 kB / 1.648 GB, free: 93.05 MB / 0.8542 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.002958/0.9562, allocations: 0.9983 MB / 1.649 GB, free: 92.03 MB / 0.8542 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.832e-05/0.9563, allocations: 11.88 kB / 1.649 GB, free: 92.02 MB / 0.8542 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001308/0.9565, allocations: 32 kB / 1.649 GB, free: 91.98 MB / 0.8542 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.203e-05/0.9565, allocations: 30 kB / 1.649 GB, free: 91.96 MB / 0.8542 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003227/0.9598, allocations: 0.9095 MB / 1.65 GB, free: 91.05 MB / 0.8542 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.00912/0.9689, allocations: 3.516 MB / 1.653 GB, free: 87.36 MB / 0.8542 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002885/0.9719, allocations: 0.6588 MB / 1.654 GB, free: 86.7 MB / 0.8542 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001391/0.9733, allocations: 352.6 kB / 1.654 GB, free: 86.35 MB / 0.8542 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002387/0.9736, allocations: 97.09 kB / 1.655 GB, free: 86.23 MB / 0.8542 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.191e-05/0.9736, allocations: 42.5 kB / 1.655 GB, free: 86.18 MB / 0.8542 GB
Notification: Performance of pre-optimization done (n=39): time 3.407e-06/0.9736, allocations: 0 / 1.655 GB, free: 86.18 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=41): time 0.01416/0.9878, allocations: 2.529 MB / 1.657 GB, free: 83.58 MB / 0.8542 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.508e-05/0.9879, allocations: 55.41 kB / 1.657 GB, free: 83.52 MB / 0.8542 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001275/0.9891, allocations: 0.7822 MB / 1.658 GB, free: 82.72 MB / 0.8542 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001437/0.9893, allocations: 37.7 kB / 1.658 GB, free: 82.68 MB / 0.8542 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003275/0.9897, allocations: 447.7 kB / 1.658 GB, free: 82.23 MB / 0.8542 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0001719/0.9898, allocations: 141.9 kB / 1.658 GB, free: 82.09 MB / 0.8542 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 5.26e-05/0.9899, allocations: 12 kB / 1.658 GB, free: 82.08 MB / 0.8542 GB
Notification: Performance of setup shared object (initialization): time 7.057e-05/0.99, allocations: 330 kB / 1.659 GB, free: 81.75 MB / 0.8542 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001386/0.9914, allocations: 312.9 kB / 1.659 GB, free: 81.45 MB / 0.8542 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001475/0.9929, allocations: 437.8 kB / 1.66 GB, free: 80.98 MB / 0.8542 GB
Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: volDyn.dynBal.medium.p = volDyn.dynBal.p_start (bou.p = volDyn.dynBal.p_start)
Notification: Performance of analyzeInitialSystem (initialization): time 0.006826/0.9997, allocations: 1.316 MB / 1.661 GB, free: 79.66 MB / 0.8542 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.392e-06/0.9998, allocations: 4 kB / 1.661 GB, free: 79.65 MB / 0.8542 GB
Notification: Performance of matching and sorting (n=63) (initialization): time 0.005591/1.005, allocations: 1.081 MB / 1.662 GB, free: 78.56 MB / 0.8542 GB
Notification: Performance of prepare postOptimizeDAE: time 2.558e-05/1.005, allocations: 8 kB / 1.662 GB, free: 78.55 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.151e-05/1.005, allocations: 0 / 1.662 GB, free: 78.55 MB / 0.8542 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009603/1.006, allocations: 196.8 kB / 1.662 GB, free: 78.36 MB / 0.8542 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001391/1.008, allocations: 159.8 kB / 1.662 GB, free: 78.2 MB / 0.8542 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.005669/1.014, allocations: 2.117 MB / 1.664 GB, free: 75.96 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001835/1.015, allocations: 95.58 kB / 1.664 GB, free: 75.87 MB / 0.8542 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.005e-05/1.016, allocations: 20 kB / 1.664 GB, free: 75.85 MB / 0.8542 GB
Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization sytem:
         volDyn.dynBal.medium.p = volDyn.dynBal.p_start.
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 (59):
 * Single equations (assignments): 58
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {1 4}
Notification: Performance of prepare postOptimizeDAE: time 0.0006245/1.016, allocations: 270.2 kB / 1.665 GB, free: 75.58 MB / 0.8542 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002272/1.016, allocations: 86.97 kB / 1.665 GB, free: 75.49 MB / 0.8542 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0002377/1.017, allocations: 100.2 kB / 1.665 GB, free: 75.39 MB / 0.8542 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.005018/1.022, allocations: 0.9485 MB / 1.666 GB, free: 74.41 MB / 0.8542 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 9.728e-06/1.022, allocations: 0 / 1.666 GB, free: 74.41 MB / 0.8542 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0007001/1.022, allocations: 236 kB / 1.666 GB, free: 74.16 MB / 0.8542 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001805/1.023, allocations: 11.94 kB / 1.666 GB, free: 74.15 MB / 0.8542 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001661/1.024, allocations: 87.58 kB / 1.666 GB, free: 74.07 MB / 0.8542 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000122/1.024, allocations: 31.94 kB / 1.666 GB, free: 74.04 MB / 0.8542 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.005767/1.03, allocations: 1.028 MB / 1.667 GB, free: 73 MB / 0.8542 GB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.004471/1.035, allocations: 1.291 MB / 1.668 GB, free: 71.69 MB / 0.8542 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.001353/1.036, allocations: 336.8 kB / 1.669 GB, free: 71.36 MB / 0.8542 GB
Notification: Performance of sorting global known variables: time 0.0009444/1.037, allocations: 0.538 MB / 1.669 GB, free: 70.82 MB / 0.8542 GB
Notification: Performance of Backend: time 4.81e-07/1.037, allocations: 3.938 kB / 1.669 GB, free: 70.82 MB / 0.8542 GB
Notification: Performance of simCode: created initialization part: time 0.003754/1.041, allocations: 0.9086 MB / 1.67 GB, free: 69.9 MB / 0.8542 GB
Notification: Performance of SimCode: time 0.006262/1.047, allocations: 2.683 MB / 1.673 GB, free: 67.18 MB / 0.8542 GB
Notification: Performance of Templates: time 0.04768/1.095, allocations: 21.06 MB / 1.693 GB, free: 46.51 MB / 0.8542 GB