Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/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 ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU")
translateModel(IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001508/0.001508, allocations: 108.5 kB / 16.64 MB, free: 6.812 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001498/0.001498, allocations: 190 kB / 17.57 MB, free: 5.918 MB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.328/1.328, allocations: 222.9 MB / 241.2 MB, free: 15.46 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.7655/0.7655, allocations: 122.9 MB / 414.2 MB, free: 16 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001446/0.001447, allocations: 67.89 kB / 0.4912 GB, free: 7.855 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3571/0.3586, allocations: 77.92 MB / 0.5673 GB, free: 32.99 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU): time 0.7291/1.088, allocations: 365.6 MB / 0.9243 GB, free: 9.754 MB / 0.6387 GB
Notification: Performance of NFInst.instExpressions: time 0.04975/1.137, allocations: 33.13 MB / 0.9567 GB, free: 8.535 MB / 0.67 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01077/1.148, allocations: 139.2 kB / 0.9568 GB, free: 8.398 MB / 0.67 GB
Notification: Performance of NFTyping.typeComponents: time 0.007466/1.156, allocations: 2.052 MB / 0.9588 GB, free: 6.336 MB / 0.67 GB
Notification: Performance of NFTyping.typeBindings: time 0.0211/1.177, allocations: 7.002 MB / 0.9657 GB, free: 15.31 MB / 0.6856 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01179/1.189, allocations: 4.206 MB / 0.9698 GB, free: 11.14 MB / 0.6856 GB
Notification: Performance of NFFlatten.flatten: time 0.01657/1.205, allocations: 11.09 MB / 0.9806 GB, free: 16 kB / 0.6856 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.006848/1.212, allocations: 3.933 MB / 0.9844 GB, free: 12.02 MB / 0.7012 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01634/1.229, allocations: 5.491 MB / 0.9898 GB, free: 6.578 MB / 0.7012 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.007274/1.236, allocations: 3.581 MB / 0.9933 GB, free: 2.996 MB / 0.7012 GB
Notification: Performance of NFPackage.collectConstants: time 0.002243/1.238, allocations: 0.5469 MB / 0.9938 GB, free: 2.449 MB / 0.7012 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01535/1.254, allocations: 7.01 MB / 1.001 GB, free: 11.43 MB / 0.7169 GB
Notification: Performance of NFScalarize.scalarize: time 0.002864/1.256, allocations: 1.48 MB / 1.002 GB, free: 9.941 MB / 0.7169 GB
Notification: Performance of NFVerifyModel.verify: time 0.006639/1.263, allocations: 2.842 MB / 1.005 GB, free: 7.086 MB / 0.7169 GB
Notification: Performance of NFConvertDAE.convert: time 0.01404/1.277, allocations: 7.469 MB / 1.012 GB, free: 15.6 MB / 0.7325 GB
Notification: Performance of FrontEnd - DAE generated: time 8.577e-06/1.277, allocations: 0 / 1.012 GB, free: 15.6 MB / 0.7325 GB
Notification: Performance of FrontEnd: time 2.464e-06/1.277, allocations: 4 kB / 1.012 GB, free: 15.6 MB / 0.7325 GB
Notification: Performance of Transformations before backend: time 0.0003135/1.278, allocations: 0 / 1.012 GB, free: 15.6 MB / 0.7325 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 851
 * Number of variables: 851
Notification: Performance of Generate backend data structure: time 0.0189/1.297, allocations: 5.951 MB / 1.018 GB, free: 9.543 MB / 0.7325 GB
Notification: Performance of prepare preOptimizeDAE: time 4.905e-05/1.297, allocations: 12.56 kB / 1.018 GB, free: 9.531 MB / 0.7325 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03193/1.329, allocations: 4.29 MB / 1.022 GB, free: 5.23 MB / 0.7325 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.009923/1.338, allocations: 3.597 MB / 1.026 GB, free: 1.57 MB / 0.7325 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001698/1.34, allocations: 0.5244 MB / 1.026 GB, free: 1.039 MB / 0.7325 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001692/1.342, allocations: 360 kB / 1.027 GB, free: 0.6875 MB / 0.7325 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.333/1.675, allocations: 5.707 MB / 1.032 GB, free: 312.2 MB / 0.7325 GB
Notification: Performance of preOpt findStateOrder (simulation): time 7.206e-05/1.675, allocations: 4.438 kB / 1.032 GB, free: 312.2 MB / 0.7325 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0005498/1.676, allocations: 137.8 kB / 1.032 GB, free: 312.1 MB / 0.7325 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002597/1.676, allocations: 134.8 kB / 1.032 GB, free: 312 MB / 0.7325 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02486/1.701, allocations: 6.823 MB / 1.039 GB, free: 310 MB / 0.7325 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.05275/1.754, allocations: 22.28 MB / 1.061 GB, free: 294.8 MB / 0.7325 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01182/1.765, allocations: 4.024 MB / 1.065 GB, free: 292.8 MB / 0.7325 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006951/1.772, allocations: 2.255 MB / 1.067 GB, free: 291.7 MB / 0.7325 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.01751/1.79, allocations: 8.171 MB / 1.075 GB, free: 285 MB / 0.7325 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.00779/1.798, allocations: 2.492 MB / 1.077 GB, free: 283.6 MB / 0.7325 GB
Notification: Performance of pre-optimization done (n=228): time 6.212e-06/1.798, allocations: 0 / 1.077 GB, free: 283.6 MB / 0.7325 GB
Notification: Performance of matching and sorting (n=228): time 0.03447/1.832, allocations: 8.42 MB / 1.086 GB, free: 279.3 MB / 0.7325 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.525e-05/1.833, allocations: 128.8 kB / 1.086 GB, free: 279.2 MB / 0.7325 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009334/1.842, allocations: 4.317 MB / 1.09 GB, free: 274.8 MB / 0.7325 GB
Notification: Performance of collectPreVariables (initialization): time 0.0009435/1.843, allocations: 81.7 kB / 1.09 GB, free: 274.7 MB / 0.7325 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002105/1.845, allocations: 1.824 MB / 1.092 GB, free: 272.9 MB / 0.7325 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001548/1.847, allocations: 0.7927 MB / 1.093 GB, free: 272.1 MB / 0.7325 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.003934/1.851, allocations: 0.8236 MB / 1.093 GB, free: 271.3 MB / 0.7325 GB
Notification: Performance of setup shared object (initialization): time 5.35e-05/1.851, allocations: 305.1 kB / 1.094 GB, free: 271 MB / 0.7325 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.009052/1.86, allocations: 2.739 MB / 1.096 GB, free: 268.3 MB / 0.7325 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01001/1.87, allocations: 3.459 MB / 1.1 GB, free: 264.6 MB / 0.7325 GB
Notification: It was not possible to check the given initialization system for consistency symbolically, because the relevant equations are part of an algebraic loop. This is not supported yet.
Notification: Performance of analyzeInitialSystem (initialization): time 0.01892/1.889, allocations: 5.959 MB / 1.106 GB, free: 258.4 MB / 0.7325 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.895e-05/1.889, allocations: 4 kB / 1.106 GB, free: 258.4 MB / 0.7325 GB
Notification: Performance of matching and sorting (n=454) (initialization): time 0.02984/1.919, allocations: 7.607 MB / 1.113 GB, free: 250.7 MB / 0.7325 GB
Notification: Performance of prepare postOptimizeDAE: time 4.344e-05/1.919, allocations: 12 kB / 1.113 GB, free: 250.7 MB / 0.7325 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.809e-05/1.919, allocations: 16 kB / 1.113 GB, free: 250.7 MB / 0.7325 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.004045/1.923, allocations: 0.9773 MB / 1.114 GB, free: 249.7 MB / 0.7325 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009216/1.932, allocations: 1.416 MB / 1.115 GB, free: 248.3 MB / 0.7325 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01497/1.947, allocations: 14.53 MB / 1.13 GB, free: 232.7 MB / 0.7325 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01181/1.959, allocations: 1.31 MB / 1.131 GB, free: 231.4 MB / 0.7325 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001418/1.96, allocations: 187.2 kB / 1.131 GB, free: 231.2 MB / 0.7325 GB
Warning: The initial conditions are over specified. The following 2 initial equations are redundant, so they are removed from the initialization system:
         hexWetNTU.UAFroRated.TAirIn = 293.15
         hexWetNTU.UAFroRated.TWatIn = 293.15.
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 65
 * Number of states: 0 ()
 * Number of discrete variables: 19 (hexWetNTU.UAFroRated.isFulWet,hexWetNTU.UAFroRated.isFulDry,$PRE.w_a2.nextTimeEvent,$whenCondition1,hexWetNTU.flowRegime_nominal,hexWetNTU.dryWetCalcs.fullyDry.cfg,hexWetNTU.dryWetCalcs.fullyWet.cfg,hexWetNTU.dryWetCalcs.cfg,hexWetNTU.flowRegime,hexWetNTU_TX.flowRegime_nominal,hexWetNTU_TX.dryWetCalcs.fullyDry.cfg,hexWetNTU_TX.dryWetCalcs.fullyWet.cfg,hexWetNTU_TX.dryWetCalcs.cfg,hexWetNTU_TX.flowRegime,hexWetNTU_TX.UAFroRated.isFulWet,hexWetNTU_TX.UAFroRated.isFulDry,w_a2.nextTimeEventScaled,$PRE.w_a2.nextTimeEventScaled,w_a2.nextTimeEvent)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (424):
 * Single equations (assignments): 409
 * Array equations: 4
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 2
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 2 systems
   {1, 1}
 * Without analytic Jacobian (size): 0 systems
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): 9 systems
   {(1,1), (1,3), (1,2), (1,2), (1,4), (1,2), (1,4), (1,2), (5,2)}
Notification: Performance of prepare postOptimizeDAE: time 0.003853/1.964, allocations: 0.8624 MB / 1.132 GB, free: 230.3 MB / 0.7325 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002289/1.967, allocations: 426.7 kB / 1.132 GB, free: 229.9 MB / 0.7325 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02269/1.989, allocations: 5.775 MB / 1.138 GB, free: 224.1 MB / 0.7325 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.108e-05/1.989, allocations: 24 kB / 1.138 GB, free: 224.1 MB / 0.7325 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.209e-05/1.989, allocations: 0 / 1.138 GB, free: 224.1 MB / 0.7325 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.726e-05/1.989, allocations: 11.95 kB / 1.138 GB, free: 224.1 MB / 0.7325 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.03254/2.022, allocations: 10.89 MB / 1.149 GB, free: 213.1 MB / 0.7325 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 2.704e-05/2.022, allocations: 4 kB / 1.149 GB, free: 213.1 MB / 0.7325 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004847/2.027, allocations: 0.671 MB / 1.149 GB, free: 212.4 MB / 0.7325 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.003054/2.03, allocations: 0.7662 MB / 1.15 GB, free: 211.6 MB / 0.7325 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0008134/2.031, allocations: 83.91 kB / 1.15 GB, free: 211.6 MB / 0.7325 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01146/2.042, allocations: 11.69 MB / 1.161 GB, free: 198.9 MB / 0.7325 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.48e-06/2.042, allocations: 7.984 kB / 1.161 GB, free: 198.9 MB / 0.7325 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02818/2.07, allocations: 8.183 MB / 1.169 GB, free: 190.7 MB / 0.7325 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003565/2.074, allocations: 1.057 MB / 1.17 GB, free: 189.6 MB / 0.7325 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00221/2.076, allocations: 51.84 kB / 1.171 GB, free: 189.5 MB / 0.7325 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0077/2.084, allocations: 0.6132 MB / 1.171 GB, free: 188.9 MB / 0.7325 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007593/2.085, allocations: 165.7 kB / 1.171 GB, free: 188.8 MB / 0.7325 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0007479/2.086, allocations: 107.9 kB / 1.171 GB, free: 188.6 MB / 0.7325 GB
Notification: Performance of sorting global known variables: time 0.007321/2.093, allocations: 2.975 MB / 1.174 GB, free: 185.7 MB / 0.7325 GB
Notification: Performance of sort global known variables: time 5.11e-07/2.093, allocations: 4 kB / 1.174 GB, free: 185.7 MB / 0.7325 GB
Notification: Performance of remove unused functions: time 0.008077/2.101, allocations: 1.556 MB / 1.176 GB, free: 184.1 MB / 0.7325 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 16
 * Number of states: 8 (relHumIn.phi,TDryBulIn.T,senMasFraIn.X,senMasFraOut.X,TDryBulOut.T,hexWetNTU.dryWetCalcs.fullyWet.TWatOutEst,relHumOut_eps.phi,hexWetNTU_TX.dryWetCalcs.fullyWet.TWatOutEst)
 * Number of discrete variables: 3 ($whenCondition1,w_a2.nextTimeEvent,w_a2.nextTimeEventScaled)
 * Number of discrete states: 2 (w_a2.nextTimeEvent,w_a2.nextTimeEventScaled)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (225):
 * Single equations (assignments): 212
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 3
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 8
 * 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): 8 systems
   {(1,4), (1,2), (1,4), (1,2), (1,1), (1,1), (1,3), (1,3)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.003322/2.104, allocations: 1.039 MB / 1.177 GB, free: 183.4 MB / 0.7325 GB
Notification: Performance of simCode: created initialization part: time 0.02513/2.13, allocations: 7.1 MB / 1.184 GB, free: 176.3 MB / 0.7325 GB
Notification: Performance of simCode: created event and clocks part: time 9.257e-06/2.13, allocations: 0 / 1.184 GB, free: 176.3 MB / 0.7325 GB
Notification: Performance of simCode: created simulation system equations: time 0.00842/2.138, allocations: 3.011 MB / 1.187 GB, free: 173.2 MB / 0.7325 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01335/2.151, allocations: 2.102 MB / 1.189 GB, free: 171.2 MB / 0.7325 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02881/2.18, allocations: 10.87 MB / 1.199 GB, free: 160.3 MB / 0.7325 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002671/2.183, allocations: 2.294 MB / 1.202 GB, free: 157.9 MB / 0.7325 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.002763/2.186, allocations: 431.1 kB / 1.202 GB, free: 157.5 MB / 0.7325 GB
Notification: Performance of SimCode: time 1.042e-06/2.186, allocations: 0 / 1.202 GB, free: 157.5 MB / 0.7325 GB
Notification: Performance of Templates: time 0.493/2.679, allocations: 259.8 MB / 1.456 GB, free: 226.6 MB / 0.7325 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU.sim & ./IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.HeatExchangers.Validation.WetCoilEffectivenessNTU.pipe 2>&1)