Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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 Buildings with version 10.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/package.mo)
Running command: translateModel(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u")
translateModel(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/package.mo): time 2.195/2.195, allocations: 391.2 MB / 407 MB, free: 10.93 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001549/0.001549, allocations: 194.1 kB / 499.1 MB, free: 4.691 MB / 394.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.63/1.63, allocations: 222.9 MB / 0.7948 GB, free: 15.77 MB / 0.5573 GB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001001/0.001001, allocations: 117.5 kB / 0.9329 GB, free: 7.098 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.001211/0.001211, allocations: 52.53 kB / 1.081 GB, free: 217.9 MB / 0.823 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3101/0.3113, allocations: 140.6 MB / 1.218 GB, free: 117.3 MB / 0.823 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Interfaces.Examples.HeaterCooler_u): time 0.9818/1.293, allocations: 298.3 MB / 1.509 GB, free: 60.58 MB / 0.9167 GB
Notification: Performance of NFInst.instExpressions: time 0.07113/1.364, allocations: 50.22 MB / 1.558 GB, free: 34.79 MB / 0.9167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01583/1.38, allocations: 277.1 kB / 1.559 GB, free: 34.68 MB / 0.9167 GB
Notification: Performance of NFTyping.typeComponents: time 0.01225/1.393, allocations: 2.792 MB / 1.561 GB, free: 32.31 MB / 0.9167 GB
Notification: Performance of NFTyping.typeBindings: time 0.03269/1.425, allocations: 8.417 MB / 1.57 GB, free: 25.49 MB / 0.9167 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01998/1.445, allocations: 6 MB / 1.575 GB, free: 20.59 MB / 0.9167 GB
Notification: Performance of NFFlatten.flatten: time 0.03007/1.476, allocations: 24.67 MB / 1.6 GB, free: 11.86 MB / 0.9323 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.01084/1.486, allocations: 4.856 MB / 1.604 GB, free: 6.906 MB / 0.9323 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01883/1.505, allocations: 6.424 MB / 1.611 GB, free: 464 kB / 0.9323 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.01247/1.518, allocations: 5.105 MB / 1.616 GB, free: 11.32 MB / 0.948 GB
Notification: Performance of NFPackage.collectConstants: time 0.003305/1.521, allocations: 304 kB / 1.616 GB, free: 11.03 MB / 0.948 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01687/1.538, allocations: 3.975 MB / 1.62 GB, free: 7.043 MB / 0.948 GB
Notification: Performance of NFScalarize.scalarize: time 0.005301/1.543, allocations: 1.24 MB / 1.621 GB, free: 5.797 MB / 0.948 GB
Notification: Performance of NFVerifyModel.verify: time 0.01218/1.556, allocations: 3.447 MB / 1.624 GB, free: 2.332 MB / 0.948 GB
Notification: Performance of NFConvertDAE.convert: time 0.0241/1.58, allocations: 10.13 MB / 1.634 GB, free: 8.172 MB / 0.9636 GB
Notification: Performance of FrontEnd - DAE generated: time 9.308e-06/1.58, allocations: 4 kB / 1.634 GB, free: 8.168 MB / 0.9636 GB
Notification: Performance of FrontEnd: time 1.443e-06/1.58, allocations: 0 / 1.634 GB, free: 8.168 MB / 0.9636 GB
Notification: Performance of Transformations before backend: time 0.0004097/1.58, allocations: 0 / 1.634 GB, free: 8.168 MB / 0.9636 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1035
 * Number of variables: 1035
Notification: Performance of Generate backend data structure: time 0.02359/1.604, allocations: 7.478 MB / 1.642 GB, free: 0.5508 MB / 0.9636 GB
Notification: Performance of prepare preOptimizeDAE: time 8.076e-05/1.604, allocations: 15.97 kB / 1.642 GB, free: 0.5352 MB / 0.9636 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005853/1.61, allocations: 0.7897 MB / 1.642 GB, free: 15.73 MB / 0.9792 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01676/1.627, allocations: 5.208 MB / 1.647 GB, free: 10.45 MB / 0.9792 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004196/1.627, allocations: 320.1 kB / 1.648 GB, free: 10.14 MB / 0.9792 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.00153/1.629, allocations: 435.9 kB / 1.648 GB, free: 9.711 MB / 0.9792 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01293/1.642, allocations: 4.385 MB / 1.652 GB, free: 5.047 MB / 0.9792 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002186/1.642, allocations: 15.88 kB / 1.652 GB, free: 5.031 MB / 0.9792 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001085/1.643, allocations: 172 kB / 1.653 GB, free: 4.863 MB / 0.9792 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001546/1.643, allocations: 120 kB / 1.653 GB, free: 4.746 MB / 0.9792 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00832/1.652, allocations: 2.965 MB / 1.656 GB, free: 1.777 MB / 0.9792 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.03763/1.689, allocations: 25.01 MB / 1.68 GB, free: 6.727 MB / 1.01 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.003963/1.693, allocations: 2.769 MB / 1.683 GB, free: 3.742 MB / 1.01 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001737/1.695, allocations: 0.9949 MB / 1.684 GB, free: 2.75 MB / 1.01 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.003196/1.698, allocations: 3.912 MB / 1.687 GB, free: 13.97 MB / 1.026 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 8.865e-05/1.698, allocations: 64.5 kB / 1.688 GB, free: 13.9 MB / 1.026 GB
Notification: Performance of pre-optimization done (n=217): time 5.49e-06/1.698, allocations: 0 / 1.688 GB, free: 13.9 MB / 1.026 GB
Notification: Performance of matching and sorting (n=217): time 0.01371/1.712, allocations: 4.072 MB / 1.692 GB, free: 9.73 MB / 1.026 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.625e-05/1.712, allocations: 73.41 kB / 1.692 GB, free: 9.648 MB / 1.026 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01015/1.722, allocations: 4.236 MB / 1.696 GB, free: 5.434 MB / 1.026 GB
Notification: Performance of collectPreVariables (initialization): time 0.0007163/1.723, allocations: 81.7 kB / 1.696 GB, free: 5.348 MB / 1.026 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00296/1.726, allocations: 2.784 MB / 1.699 GB, free: 2.543 MB / 1.026 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001389/1.728, allocations: 0.7625 MB / 1.699 GB, free: 1.77 MB / 1.026 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00169/1.729, allocations: 0.5723 MB / 1.7 GB, free: 1.191 MB / 1.026 GB
Notification: Performance of setup shared object (initialization): time 9.707e-05/1.729, allocations: 305.1 kB / 1.7 GB, free: 0.8906 MB / 1.026 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001567/1.731, allocations: 0.827 MB / 1.701 GB, free: 60 kB / 1.026 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002284/1.733, allocations: 1.814 MB / 1.703 GB, free: 13.8 MB / 1.042 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003569/1.737, allocations: 2.521 MB / 1.705 GB, free: 10.96 MB / 1.042 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.36e-05/1.737, allocations: 8 kB / 1.705 GB, free: 10.95 MB / 1.042 GB
Notification: Performance of matching and sorting (n=365) (initialization): time 0.008276/1.745, allocations: 3.551 MB / 1.709 GB, free: 7.332 MB / 1.042 GB
Notification: Performance of prepare postOptimizeDAE: time 3.547e-05/1.745, allocations: 16.22 kB / 1.709 GB, free: 7.316 MB / 1.042 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.734e-05/1.745, allocations: 27.98 kB / 1.709 GB, free: 7.289 MB / 1.042 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.002547/1.748, allocations: 0.579 MB / 1.709 GB, free: 6.699 MB / 1.042 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00209/1.75, allocations: 0.55 MB / 1.71 GB, free: 6.148 MB / 1.042 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002204/1.752, allocations: 2.691 MB / 1.712 GB, free: 3.355 MB / 1.042 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006041/1.758, allocations: 0.5918 MB / 1.713 GB, free: 2.762 MB / 1.042 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004998/1.759, allocations: 136 kB / 1.713 GB, free: 2.629 MB / 1.042 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.003392/1.762, allocations: 1.576 MB / 1.715 GB, free: 1.047 MB / 1.042 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.002145/1.764, allocations: 1.795 MB / 1.716 GB, free: 14.82 MB / 1.057 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.003608/1.768, allocations: 2.467 MB / 1.719 GB, free: 12.02 MB / 1.057 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.253e-05/1.768, allocations: 12 kB / 1.719 GB, free: 12 MB / 1.057 GB
Notification: Performance of matching and sorting (n=365) (initialization_lambda0): time 0.00806/1.776, allocations: 3.306 MB / 1.722 GB, free: 8.633 MB / 1.057 GB
Notification: Performance of prepare postOptimizeDAE: time 2.942e-05/1.776, allocations: 17.34 kB / 1.722 GB, free: 8.617 MB / 1.057 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.649e-05/1.776, allocations: 24 kB / 1.722 GB, free: 8.594 MB / 1.057 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001025/1.777, allocations: 369.7 kB / 1.722 GB, free: 8.223 MB / 1.057 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00175/1.779, allocations: 0.5538 MB / 1.723 GB, free: 7.668 MB / 1.057 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008791/1.788, allocations: 7.683 MB / 1.73 GB, free: 15.4 MB / 1.073 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006164/1.794, allocations: 0.5698 MB / 1.731 GB, free: 14.83 MB / 1.073 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00064/1.795, allocations: 136 kB / 1.731 GB, free: 14.7 MB / 1.073 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 97
 * 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 (323):
 * Single equations (assignments): 319
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(1,12), (1,9), (1,12), (1,9)}
Notification: Performance of prepare postOptimizeDAE: time 0.0009502/1.796, allocations: 365.3 kB / 1.732 GB, free: 14.34 MB / 1.073 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002209/1.798, allocations: 0.5055 MB / 1.732 GB, free: 13.82 MB / 1.073 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006748/1.805, allocations: 3.585 MB / 1.736 GB, free: 10.17 MB / 1.073 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 5.038e-05/1.805, allocations: 31.98 kB / 1.736 GB, free: 10.14 MB / 1.073 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.376e-06/1.805, allocations: 7.922 kB / 1.736 GB, free: 10.13 MB / 1.073 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003881/1.808, allocations: 2.447 MB / 1.738 GB, free: 7.633 MB / 1.073 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 postOpt removeSimpleEquations (simulation): time 0.01639/1.825, allocations: 8.198 MB / 1.746 GB, free: 15.15 MB / 1.089 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.302e-05/1.825, allocations: 4 kB / 1.746 GB, free: 15.15 MB / 1.089 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00132/1.826, allocations: 367.5 kB / 1.746 GB, free: 14.79 MB / 1.089 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0007697/1.827, allocations: 315.1 kB / 1.747 GB, free: 14.47 MB / 1.089 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001341/1.827, allocations: 59.97 kB / 1.747 GB, free: 14.41 MB / 1.089 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001933/1.829, allocations: 2.498 MB / 1.749 GB, free: 11.81 MB / 1.089 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.23e-06/1.829, allocations: 7.938 kB / 1.749 GB, free: 11.8 MB / 1.089 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04778/1.877, allocations: 25.35 MB / 1.774 GB, free: 1.504 MB / 1.104 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.002867/1.88, allocations: 0.8844 MB / 1.775 GB, free: 0.5938 MB / 1.104 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0009216/1.881, allocations: 44 kB / 1.775 GB, free: 0.5508 MB / 1.104 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0037/1.885, allocations: 431.3 kB / 1.775 GB, free: 132 kB / 1.104 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000306/1.885, allocations: 149.8 kB / 1.775 GB, free: 15.98 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002926/1.885, allocations: 108.1 kB / 1.775 GB, free: 15.88 MB / 1.12 GB
Notification: Performance of sorting global known variables: time 0.005272/1.89, allocations: 2.797 MB / 1.778 GB, free: 13.11 MB / 1.12 GB
Notification: Performance of sort global known variables: time 5.41e-07/1.89, allocations: 7.938 kB / 1.778 GB, free: 13.1 MB / 1.12 GB
Notification: Performance of remove unused functions: time 0.02955/1.92, allocations: 4.98 MB / 1.783 GB, free: 8.109 MB / 1.12 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 10 (hea1.vol.dynBal.U,hea2.vol.dynBal.U,hea3.vol.dynBal.U,hea4.vol.dynBal.U,mix1.dynBal.U,hea5.vol.dynBal.U,hea6.vol.dynBal.U,hea7.vol.dynBal.U,hea8.vol.dynBal.U,mix2.dynBal.U)
 * 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 (219):
 * Single equations (assignments): 181
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 34
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 4
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 4 systems
   {(1,9), (1,7), (1,9), (1,7)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.003554/1.924, allocations: 1.468 MB / 1.784 GB, free: 6.637 MB / 1.12 GB
Notification: Performance of simCode: created initialization part: time 0.008295/1.932, allocations: 4.417 MB / 1.789 GB, free: 2.156 MB / 1.12 GB
Notification: Performance of simCode: created event and clocks part: time 9.417e-06/1.932, allocations: 4 kB / 1.789 GB, free: 2.152 MB / 1.12 GB
Notification: Performance of simCode: created simulation system equations: time 0.002211/1.934, allocations: 1.226 MB / 1.79 GB, free: 0.9297 MB / 1.12 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01488/1.949, allocations: 2.649 MB / 1.793 GB, free: 14.31 MB / 1.135 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02399/1.973, allocations: 13.35 MB / 1.806 GB, free: 0.8633 MB / 1.135 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003699/1.977, allocations: 2.982 MB / 1.809 GB, free: 13.85 MB / 1.151 GB
Notification: Performance of simCode: alias equations: time 0.005779/1.983, allocations: 1.192 MB / 1.81 GB, free: 12.65 MB / 1.151 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001278/1.984, allocations: 427.2 kB / 1.81 GB, free: 12.24 MB / 1.151 GB
Notification: Performance of SimCode: time 1.352e-06/1.984, allocations: 0 / 1.81 GB, free: 12.24 MB / 1.151 GB
Notification: Performance of Templates: time 0.7742/2.758, allocations: 110.7 MB / 1.918 GB, free: 439.1 MB / 1.214 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.makefile
(rm -f Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe >> ../files/Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.sim & ./Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Interfaces.Examples.HeaterCooler_u.pipe 2>&1)