Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+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/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/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 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 8.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo)
Running command: translateModel(Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger")
translateModel(Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.0.0/package.mo): time 2.651/2.651, allocations: 287.3 MB / 302.3 MB, free: 8.355 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001766/0.001766, allocations: 174.2 kB / 370.8 MB, free: 10.85 MB / 298.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.181/2.181, allocations: 205.4 MB / 0.6295 GB, free: 10.58 MB / 458.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001149/0.001149, allocations: 93.64 kB / 0.7428 GB, free: 6.602 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0004872/0.0004873, allocations: 13.73 kB / 0.8656 GB, free: 140.7 MB / 0.6198 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2258/0.2264, allocations: 115.3 MB / 0.9782 GB, free: 28.4 MB / 0.6198 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger): time 0.06813/0.2946, allocations: 34.81 MB / 1.012 GB, free: 9.496 MB / 0.6355 GB
Notification: Performance of NFInst.instExpressions: time 0.02718/0.3218, allocations: 8.854 MB / 1.021 GB, free: 0.625 MB / 0.6355 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002324/0.3242, allocations: 43.69 kB / 1.021 GB, free: 0.582 MB / 0.6355 GB
Notification: Performance of NFTyping.typeComponents: time 0.004044/0.3283, allocations: 0.6181 MB / 1.021 GB, free: 15.96 MB / 0.6511 GB
Notification: Performance of NFTyping.typeBindings: time 0.008154/0.3365, allocations: 1.776 MB / 1.023 GB, free: 14.18 MB / 0.6511 GB
Notification: Performance of NFTyping.typeClassSections: time 0.006367/0.3429, allocations: 1.367 MB / 1.025 GB, free: 12.84 MB / 0.6511 GB
Notification: Performance of NFFlatten.flatten: time 0.005321/0.3482, allocations: 1.95 MB / 1.026 GB, free: 10.89 MB / 0.6511 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001968/0.3503, allocations: 0.7538 MB / 1.027 GB, free: 10.13 MB / 0.6511 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.003043/0.3534, allocations: 0.8835 MB / 1.028 GB, free: 9.242 MB / 0.6511 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001628/0.355, allocations: 0.5482 MB / 1.029 GB, free: 8.691 MB / 0.6511 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003142/0.3554, allocations: 36 kB / 1.029 GB, free: 8.656 MB / 0.6511 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.002857/0.3583, allocations: 0.5422 MB / 1.029 GB, free: 8.113 MB / 0.6511 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004936/0.3588, allocations: 195.2 kB / 1.029 GB, free: 7.922 MB / 0.6511 GB
Notification: Performance of NFVerifyModel.verify: time 0.0006392/0.3595, allocations: 257.1 kB / 1.03 GB, free: 7.664 MB / 0.6511 GB
Notification: Performance of NFConvertDAE.convert: time 0.003298/0.3628, allocations: 1.36 MB / 1.031 GB, free: 6.301 MB / 0.6511 GB
Notification: Performance of FrontEnd - DAE generated: time 4.638e-06/0.3628, allocations: 4 kB / 1.031 GB, free: 6.297 MB / 0.6511 GB
Notification: Performance of FrontEnd: time 3.066e-06/0.3629, allocations: 0 / 1.031 GB, free: 6.297 MB / 0.6511 GB
Notification: Performance of Transformations before backend: time 7.904e-05/0.3629, allocations: 0 / 1.031 GB, free: 6.297 MB / 0.6511 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 174
 * Number of variables: 174
Notification: Performance of Generate backend data structure: time 0.00371/0.3667, allocations: 1.304 MB / 1.032 GB, free: 4.938 MB / 0.6511 GB
Notification: Performance of prepare preOptimizeDAE: time 5.096e-05/0.3667, allocations: 12.02 kB / 1.032 GB, free: 4.926 MB / 0.6511 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0006699/0.3674, allocations: 130.5 kB / 1.032 GB, free: 4.797 MB / 0.6511 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002806/0.3702, allocations: 0.9669 MB / 1.033 GB, free: 3.789 MB / 0.6511 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 8.802e-05/0.3704, allocations: 61.94 kB / 1.033 GB, free: 3.727 MB / 0.6511 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001843/0.3706, allocations: 75.98 kB / 1.033 GB, free: 3.652 MB / 0.6511 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00244/0.373, allocations: 0.7866 MB / 1.034 GB, free: 2.832 MB / 0.6511 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.728e-05/0.3731, allocations: 0 / 1.034 GB, free: 2.832 MB / 0.6511 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001151/0.3732, allocations: 28 kB / 1.034 GB, free: 2.805 MB / 0.6511 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.694e-05/0.3733, allocations: 16 kB / 1.034 GB, free: 2.789 MB / 0.6511 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002214/0.3755, allocations: 0.5906 MB / 1.035 GB, free: 2.199 MB / 0.6511 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.00728/0.3829, allocations: 3.583 MB / 1.038 GB, free: 14.39 MB / 0.6667 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.00101/0.3839, allocations: 270.5 kB / 1.039 GB, free: 14.12 MB / 0.6667 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007354/0.3847, allocations: 0.6571 MB / 1.039 GB, free: 13.31 MB / 0.6667 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.156e-05/0.3848, allocations: 35.09 kB / 1.039 GB, free: 13.27 MB / 0.6667 GB
Notification: Performance of pre-optimization done (n=31): time 3.227e-06/0.3848, allocations: 0 / 1.039 GB, free: 13.27 MB / 0.6667 GB
Notification: Performance of matching and sorting (n=31): time 0.002175/0.387, allocations: 0.5432 MB / 1.04 GB, free: 12.72 MB / 0.6667 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.612e-05/0.3871, allocations: 55.41 kB / 1.04 GB, free: 12.65 MB / 0.6667 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002057/0.3891, allocations: 0.9682 MB / 1.041 GB, free: 11.66 MB / 0.6667 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001091/0.3893, allocations: 33.7 kB / 1.041 GB, free: 11.62 MB / 0.6667 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0005972/0.3899, allocations: 499.6 kB / 1.041 GB, free: 11.13 MB / 0.6667 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002586/0.3902, allocations: 110.4 kB / 1.041 GB, free: 11.02 MB / 0.6667 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 5.818e-05/0.3902, allocations: 12 kB / 1.041 GB, free: 11.01 MB / 0.6667 GB
Notification: Performance of setup shared object (initialization): time 0.0002697/0.3905, allocations: 326 kB / 1.042 GB, free: 10.68 MB / 0.6667 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001577/0.3921, allocations: 177 kB / 1.042 GB, free: 10.51 MB / 0.6667 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0009018/0.3931, allocations: 358.9 kB / 1.042 GB, free: 10.09 MB / 0.6667 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007922/0.3939, allocations: 231.8 kB / 1.042 GB, free: 9.859 MB / 0.6667 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.742e-06/0.3939, allocations: 0 / 1.042 GB, free: 9.859 MB / 0.6667 GB
Notification: Performance of matching and sorting (n=65) (initialization): time 0.002191/0.3961, allocations: 0.6251 MB / 1.043 GB, free: 9.227 MB / 0.6667 GB
Notification: Performance of prepare postOptimizeDAE: time 3.388e-05/0.3962, allocations: 8 kB / 1.043 GB, free: 9.219 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.761e-05/0.3962, allocations: 7.984 kB / 1.043 GB, free: 9.211 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.013e-05/0.3963, allocations: 8 kB / 1.043 GB, free: 9.203 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008932/0.3972, allocations: 140.2 kB / 1.043 GB, free: 9.066 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.979e-05/0.3972, allocations: 8 kB / 1.043 GB, free: 9.059 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001334/0.3986, allocations: 119.1 kB / 1.043 GB, free: 8.941 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.34e-05/0.3987, allocations: 35.95 kB / 1.043 GB, free: 8.906 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 23
 * 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 (65):
 * Single equations (assignments): 65
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0007433/0.3994, allocations: 270.7 kB / 1.044 GB, free: 8.633 MB / 0.6667 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.000312/0.3998, allocations: 98.78 kB / 1.044 GB, free: 8.535 MB / 0.6667 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001771/0.4016, allocations: 0.4967 MB / 1.044 GB, free: 8.027 MB / 0.6667 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.764e-05/0.4016, allocations: 4.062 kB / 1.044 GB, free: 8.023 MB / 0.6667 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 9.128e-06/0.4016, allocations: 4 kB / 1.044 GB, free: 8.02 MB / 0.6667 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00132/0.403, allocations: 476.8 kB / 1.045 GB, free: 7.523 MB / 0.6667 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003771/0.4068, allocations: 1.393 MB / 1.046 GB, free: 6.059 MB / 0.6667 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 8.055e-06/0.4068, allocations: 4.156 kB / 1.046 GB, free: 6.055 MB / 0.6667 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006939/0.4075, allocations: 87.81 kB / 1.046 GB, free: 5.969 MB / 0.6667 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.445e-05/0.4076, allocations: 4 kB / 1.046 GB, free: 5.965 MB / 0.6667 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.772e-05/0.4076, allocations: 15.89 kB / 1.046 GB, free: 5.949 MB / 0.6667 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.177e-06/0.4076, allocations: 4 kB / 1.046 GB, free: 5.945 MB / 0.6667 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.898e-06/0.4077, allocations: 0 / 1.046 GB, free: 5.945 MB / 0.6667 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002437/0.4101, allocations: 0.8591 MB / 1.047 GB, free: 5.031 MB / 0.6667 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0006695/0.4108, allocations: 251.7 kB / 1.047 GB, free: 4.766 MB / 0.6667 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002147/0.411, allocations: 8 kB / 1.047 GB, free: 4.758 MB / 0.6667 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.00107/0.4121, allocations: 54.88 kB / 1.047 GB, free: 4.707 MB / 0.6667 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001183/0.4123, allocations: 31.92 kB / 1.047 GB, free: 4.676 MB / 0.6667 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 6.625e-05/0.4123, allocations: 23.98 kB / 1.047 GB, free: 4.652 MB / 0.6667 GB
Notification: Performance of sorting global known variables: time 0.001472/0.4138, allocations: 0.6704 MB / 1.048 GB, free: 3.973 MB / 0.6667 GB
Notification: Performance of sort global known variables: time 5.21e-07/0.4138, allocations: 0 / 1.048 GB, free: 3.973 MB / 0.6667 GB
Notification: Performance of remove unused functions: time 0.001587/0.4154, allocations: 343.4 kB / 1.048 GB, free: 3.637 MB / 0.6667 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 6
 * Number of states: 2 (fouPor.vol1.dynBal.U,fouPor.vol2.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 (34):
 * Single equations (assignments): 31
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 3
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.001072/0.4165, allocations: 375.7 kB / 1.049 GB, free: 3.27 MB / 0.6667 GB
Notification: Performance of simCode: created initialization part: time 0.001585/0.4181, allocations: 440.9 kB / 1.049 GB, free: 2.84 MB / 0.6667 GB
Notification: Performance of simCode: created event and clocks part: time 6.142e-06/0.4182, allocations: 0 / 1.049 GB, free: 2.84 MB / 0.6667 GB
Notification: Performance of simCode: created simulation system equations: time 0.0007355/0.4189, allocations: 205 kB / 1.049 GB, free: 2.641 MB / 0.6667 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005196/0.4242, allocations: 0.5981 MB / 1.05 GB, free: 2.047 MB / 0.6667 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004346/0.4285, allocations: 1.946 MB / 1.052 GB, free: 56 kB / 0.6667 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0009219/0.4295, allocations: 1.052 MB / 1.053 GB, free: 14.97 MB / 0.6823 GB
Notification: Performance of simCode: alias equations: time 0.001404/0.4309, allocations: 195.4 kB / 1.053 GB, free: 14.78 MB / 0.6823 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003034/0.4313, allocations: 87.41 kB / 1.053 GB, free: 14.7 MB / 0.6823 GB
Notification: Performance of SimCode: time 1.152e-06/0.4313, allocations: 0 / 1.053 GB, free: 14.7 MB / 0.6823 GB
Notification: Performance of Templates: time 0.6608/1.092, allocations: 20.2 MB / 1.073 GB, free: 82.48 MB / 0.6823 GB
make -j1 -f Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.makefile
(rm -f Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.pipe ; mkfifo Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.pipe ; head -c 1048576 < Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.pipe >> ../files/Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.sim & ./Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8.0.0_Buildings.Fluid.Interfaces.Examples.FourPortHeatMassExchanger.pipe 2>&1)