Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/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 9.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo)
Running command: translateModel(Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|hex.sta_a1.T|hex.sta_b1.T|hex.Q2_flow|hex.port_a2.m_flow|hex.port_b2.m_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow")
translateModel(Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|hex.sta_a1.T|hex.sta_b1.T|hex.Q2_flow|hex.port_a2.m_flow|hex.port_b2.m_flow",fileNamePrefix="Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.1.1-maint.9.1.x/package.mo): time 2.237/2.237, allocations: 390.3 MB / 405.3 MB, free: 13.48 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.001153/0.001153, allocations: 182.7 kB / 498.1 MB, free: 5.746 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.542/1.542, allocations: 223.2 MB / 0.7948 GB, free: 17.93 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.001129/0.001129, allocations: 103.9 kB / 0.9346 GB, free: 6.176 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003603/0.0003605, allocations: 10.31 kB / 1.084 GB, free: 221.1 MB / 0.823 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3131/0.3135, allocations: 142.3 MB / 1.223 GB, free: 114.2 MB / 0.823 GB
Notification: Performance of FrontEnd - scodeFlatten: time 5.543/5.856, allocations: 2.208 GB / 3.431 GB, free: 276.6 MB / 1.167 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002696/5.857, allocations: 101 kB / 3.431 GB, free: 276.5 MB / 1.167 GB
Notification: Performance of FrontEnd - DAE generated: time 8.397/14.25, allocations: 2.093 GB / 5.525 GB, free: 182.1 MB / 1.198 GB
Notification: Performance of FrontEnd: time 2.675e-06/14.25, allocations: 0 / 5.525 GB, free: 182.1 MB / 1.198 GB
Notification: Performance of Transformations before backend: time 0.001173/14.25, allocations: 139.4 kB / 5.525 GB, free: 182.1 MB / 1.198 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1021
 * Number of variables: 1021
Notification: Performance of Generate backend data structure: time 0.02612/14.28, allocations: 6.361 MB / 5.531 GB, free: 180.1 MB / 1.198 GB
Notification: Performance of prepare preOptimizeDAE: time 4.073e-05/14.28, allocations: 6.75 kB / 5.531 GB, free: 180.1 MB / 1.198 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.009145/14.29, allocations: 1.239 MB / 5.532 GB, free: 179.8 MB / 1.198 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01837/14.31, allocations: 6.822 MB / 5.539 GB, free: 179.1 MB / 1.198 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003072/14.31, allocations: 297.9 kB / 5.539 GB, free: 179.1 MB / 1.198 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001536/14.31, allocations: 404.8 kB / 5.54 GB, free: 179.1 MB / 1.198 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01179/14.32, allocations: 5.604 MB / 5.545 GB, free: 178.8 MB / 1.198 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001128/14.32, allocations: 10.69 kB / 5.545 GB, free: 178.8 MB / 1.198 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005397/14.32, allocations: 164.2 kB / 5.545 GB, free: 178.8 MB / 1.198 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001667/14.32, allocations: 189.3 kB / 5.545 GB, free: 178.8 MB / 1.198 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.009192/14.33, allocations: 4.906 MB / 5.55 GB, free: 178.7 MB / 1.198 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.03571/14.37, allocations: 24.13 MB / 5.574 GB, free: 169.4 MB / 1.198 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004803/14.37, allocations: 3.601 MB / 5.577 GB, free: 169 MB / 1.198 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.001108/14.37, allocations: 1.006 MB / 5.578 GB, free: 167.9 MB / 1.198 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003221/14.38, allocations: 1.917 MB / 5.58 GB, free: 167.8 MB / 1.198 GB
Notification: Performance of pre-optimization done (n=273): time 4.749e-06/14.38, allocations: 0 / 5.58 GB, free: 167.8 MB / 1.198 GB
Notification: Performance of matching and sorting (n=277): time 0.0191/14.4, allocations: 9.933 MB / 5.59 GB, free: 165.9 MB / 1.198 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001047/14.4, allocations: 134.6 kB / 5.59 GB, free: 165.8 MB / 1.198 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.006332/14.4, allocations: 3.943 MB / 5.594 GB, free: 165.5 MB / 1.198 GB
Notification: Performance of collectPreVariables (initialization): time 0.0006671/14.4, allocations: 81.05 kB / 5.594 GB, free: 165.5 MB / 1.198 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002457/14.41, allocations: 2.243 MB / 5.596 GB, free: 164.8 MB / 1.198 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001451/14.41, allocations: 0.9497 MB / 5.597 GB, free: 164.2 MB / 1.198 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002124/14.41, allocations: 54.22 kB / 5.597 GB, free: 164.2 MB / 1.198 GB
Notification: Performance of setup shared object (initialization): time 0.0001796/14.41, allocations: 417.2 kB / 5.597 GB, free: 163.9 MB / 1.198 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.002573/14.41, allocations: 1.506 MB / 5.599 GB, free: 163.8 MB / 1.198 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002923/14.41, allocations: 2.155 MB / 5.601 GB, free: 163.2 MB / 1.198 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002502/14.42, allocations: 1.967 MB / 5.603 GB, free: 163.1 MB / 1.198 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.737e-06/14.42, allocations: 5.219 kB / 5.603 GB, free: 163.1 MB / 1.198 GB
Notification: Performance of matching and sorting (n=353) (initialization): time 0.006772/14.42, allocations: 4.373 MB / 5.607 GB, free: 162.7 MB / 1.198 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000865/14.42, allocations: 5.205 MB / 5.612 GB, free: 157.4 MB / 1.198 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.055e-05/14.42, allocations: 13.84 kB / 5.612 GB, free: 157.4 MB / 1.198 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003828/14.42, allocations: 125.5 kB / 5.612 GB, free: 157.4 MB / 1.198 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00269/14.43, allocations: 0.6197 MB / 5.613 GB, free: 157.4 MB / 1.198 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002109/14.43, allocations: 2.789 MB / 5.616 GB, free: 155.5 MB / 1.198 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005674/14.43, allocations: 0.5151 MB / 5.616 GB, free: 155.4 MB / 1.198 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004479/14.44, allocations: 116.4 kB / 5.616 GB, free: 155.4 MB / 1.198 GB
Notification: Performance of prepare postOptimizeDAE: time 1.035e-05/14.44, allocations: 3.562 kB / 5.616 GB, free: 155.4 MB / 1.198 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005858/14.44, allocations: 4.021 MB / 5.62 GB, free: 155.3 MB / 1.198 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.549e-05/14.44, allocations: 11.5 kB / 5.62 GB, free: 155.3 MB / 1.198 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003315/14.44, allocations: 124.7 kB / 5.62 GB, free: 155.3 MB / 1.198 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002543/14.44, allocations: 0.6154 MB / 5.621 GB, free: 155.3 MB / 1.198 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001805/14.45, allocations: 2.186 MB / 5.623 GB, free: 153.9 MB / 1.198 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005545/14.45, allocations: 0.4946 MB / 5.624 GB, free: 153.9 MB / 1.198 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005378/14.45, allocations: 117.7 kB / 5.624 GB, free: 153.9 MB / 1.198 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 51
 * Number of states: 0 ()
 * Number of discrete variables: 14 ($whenCondition1,$whenCondition2,mWatGai.a,mWatGai.b,mWatGai.last,$PRE.mWatGai.nextEvent,mWatGai.nextEvent,mWatGai.nextEventScaled,mAirGai.a,mAirGai.b,mAirGai.last,$PRE.mAirGai.nextEvent,mAirGai.nextEvent,mAirGai.nextEventScaled)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (336):
 * Single equations (assignments): 332
 * Array equations: 0
 * Algorithm blocks: 2
 * 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%) 7}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.005259/14.46, allocations: 2.177 MB / 5.626 GB, free: 153.6 MB / 1.198 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001705/14.46, allocations: 429.5 kB / 5.626 GB, free: 153.4 MB / 1.198 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.007195/14.47, allocations: 4.19 MB / 5.63 GB, free: 153.1 MB / 1.198 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.338e-05/14.47, allocations: 31.23 kB / 5.63 GB, free: 153.1 MB / 1.198 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.593e-06/14.47, allocations: 0 / 5.63 GB, free: 153.1 MB / 1.198 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004449/14.47, allocations: 3.519 MB / 5.634 GB, free: 152.8 MB / 1.198 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.01879/14.49, allocations: 10.59 MB / 5.644 GB, free: 151.7 MB / 1.198 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.202e-05/14.49, allocations: 3.75 kB / 5.644 GB, free: 151.7 MB / 1.198 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002754/14.49, allocations: 0.6178 MB / 5.645 GB, free: 151.7 MB / 1.198 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003543/14.49, allocations: 107.4 kB / 5.645 GB, free: 151.7 MB / 1.198 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0002461/14.49, allocations: 91.98 kB / 5.645 GB, free: 151.7 MB / 1.198 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001886/14.49, allocations: 2.767 MB / 5.648 GB, free: 149.7 MB / 1.198 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.607e-06/14.49, allocations: 6.812 kB / 5.648 GB, free: 149.7 MB / 1.198 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.008707/14.5, allocations: 6.629 MB / 5.654 GB, free: 148.5 MB / 1.198 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003915/14.51, allocations: 1.078 MB / 5.655 GB, free: 148.1 MB / 1.198 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001179/14.51, allocations: 69.7 kB / 5.655 GB, free: 148.1 MB / 1.198 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004303/14.51, allocations: 454.6 kB / 5.656 GB, free: 148.1 MB / 1.198 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0003499/14.51, allocations: 173.4 kB / 5.656 GB, free: 148.1 MB / 1.198 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002857/14.51, allocations: 111.5 kB / 5.656 GB, free: 148.1 MB / 1.198 GB
Notification: Performance of sorting global known variables: time 0.005108/14.52, allocations: 3.122 MB / 5.659 GB, free: 147.9 MB / 1.198 GB
Notification: Performance of sort global known variables: time 3.71e-07/14.52, allocations: 2.969 kB / 5.659 GB, free: 147.9 MB / 1.198 GB
Notification: Performance of remove unused functions: time 0.01183/14.53, allocations: 2.742 MB / 5.662 GB, free: 147.9 MB / 1.198 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 17
 * Number of states: 18 (hex.ele[1].vol1.dynBal.U,hex.ele[1].vol2.dynBal.medium.Xi[1],hex.ele[1].vol2.dynBal.U,hex.ele[1].mas.T,hex.ele[2].vol1.dynBal.U,hex.ele[2].vol2.dynBal.medium.Xi[1],hex.ele[2].vol2.dynBal.U,hex.ele[2].mas.T,hex.ele[3].vol1.dynBal.U,hex.ele[3].vol2.dynBal.medium.Xi[1],hex.ele[3].vol2.dynBal.U,hex.ele[3].mas.T,hex.ele[4].vol1.dynBal.U,hex.ele[4].vol2.dynBal.medium.Xi[1],hex.ele[4].vol2.dynBal.U,hex.ele[4].vol2.dynBal.m,hex.ele[4].mas.T,senRelHum.phi)
 * Number of discrete variables: 12 ($whenCondition1,$whenCondition2,mWatGai.a,mWatGai.b,mWatGai.last,mWatGai.nextEvent,mWatGai.nextEventScaled,mAirGai.a,mAirGai.b,mAirGai.last,mAirGai.nextEvent,mAirGai.nextEventScaled)
 * Number of discrete states: 12 (mAirGai.nextEvent,mAirGai.last,mAirGai.nextEventScaled,mAirGai.b,mAirGai.a,$whenCondition2,mWatGai.nextEvent,mWatGai.last,mWatGai.nextEventScaled,mWatGai.b,mWatGai.a,$whenCondition1)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (266):
 * Single equations (assignments): 258
 * Array equations: 0
 * Algorithm blocks: 2
 * Record equations: 4
 * 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%) 7}
 * Non-linear torn systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.004826/14.54, allocations: 2.786 MB / 5.664 GB, free: 146.9 MB / 1.198 GB
Notification: Performance of simCode: created initialization part: time 0.009496/14.54, allocations: 6.202 MB / 5.67 GB, free: 146.3 MB / 1.198 GB
Notification: Performance of simCode: created event and clocks part: time 1.18e-05/14.54, allocations: 3.906 kB / 5.67 GB, free: 146.3 MB / 1.198 GB
Notification: Performance of simCode: created simulation system equations: time 0.002749/14.55, allocations: 2.08 MB / 5.672 GB, free: 146.1 MB / 1.198 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01318/14.56, allocations: 2.784 MB / 5.675 GB, free: 146 MB / 1.198 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02421/14.59, allocations: 13.54 MB / 5.688 GB, free: 141.4 MB / 1.198 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003805/14.59, allocations: 4.041 MB / 5.692 GB, free: 140.6 MB / 1.198 GB
Notification: Performance of simCode: alias equations: time 0.007752/14.6, allocations: 2.403 MB / 5.695 GB, free: 140.6 MB / 1.198 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.00146/14.6, allocations: 333.3 kB / 5.695 GB, free: 140.6 MB / 1.198 GB
Notification: Performance of SimCode: time 9.52e-07/14.6, allocations: 0 / 5.695 GB, free: 140.6 MB / 1.198 GB
Notification: Performance of Templates: time 0.1655/14.76, allocations: 122.4 MB / 5.815 GB, free: 101.6 MB / 1.198 GB
make -j1 -f Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.makefile
(rm -f Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.pipe ; mkfifo Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.pipe ; head -c 1048576 < Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.pipe >> ../files/Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.sim & ./Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.pipe 2>&1)
diffSimulationResults("Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow_res.mat","/mnt/ReferenceFiles/Buildings/csv/maint_9.1.x/Buildings_Fluid_HeatExchangers_Examples_DryCoilCounterFlowMassFlow.csv","../files/Buildings_9_Buildings.Fluid.HeatExchangers.Examples.DryCoilCounterFlowMassFlow.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001)
Reference file matches