Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.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.Examples.WaterCooler_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T")
translateModel(IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001326/0.001326, allocations: 101.2 kB / 16.27 MB, free: 5.969 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.001492/0.001492, allocations: 192 kB / 17.2 MB, free: 5.598 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.444/1.444, allocations: 222.9 MB / 240.9 MB, free: 15.2 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.8156/0.8156, allocations: 126.7 MB / 417.8 MB, free: 12.33 MB / 334.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001914/0.001914, allocations: 67.89 kB / 0.4957 GB, free: 2.797 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3478/0.3497, allocations: 78.86 MB / 0.5728 GB, free: 30.84 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T): time 0.04945/0.3992, allocations: 53.74 MB / 0.6252 GB, free: 15.98 MB / 478.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02872/0.428, allocations: 17.01 MB / 0.6418 GB, free: 14.91 MB / 494.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.003137/0.4312, allocations: 87.5 kB / 0.6419 GB, free: 14.83 MB / 494.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.009763/0.441, allocations: 4.408 MB / 0.6462 GB, free: 10.42 MB / 494.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.007156/0.4482, allocations: 2.374 MB / 0.6486 GB, free: 8.035 MB / 494.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00619/0.4544, allocations: 2.267 MB / 0.6508 GB, free: 5.785 MB / 494.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01064/0.465, allocations: 6.892 MB / 0.6575 GB, free: 14.88 MB / 0.4981 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.003068/0.4681, allocations: 1.624 MB / 0.6591 GB, free: 13.23 MB / 0.4981 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.005042/0.4732, allocations: 1.995 MB / 0.661 GB, free: 11.23 MB / 0.4981 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00261/0.4758, allocations: 1.365 MB / 0.6624 GB, free: 9.859 MB / 0.4981 GB
Notification: Performance of NFPackage.collectConstants: time 0.0006421/0.4764, allocations: 172 kB / 0.6625 GB, free: 9.691 MB / 0.4981 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.004769/0.4812, allocations: 1.997 MB / 0.6645 GB, free: 7.691 MB / 0.4981 GB
Notification: Performance of NFScalarize.scalarize: time 0.00107/0.4823, allocations: 0.6423 MB / 0.6651 GB, free: 7.047 MB / 0.4981 GB
Notification: Performance of NFVerifyModel.verify: time 0.002578/0.4849, allocations: 1.201 MB / 0.6663 GB, free: 5.84 MB / 0.4981 GB
Notification: Performance of NFConvertDAE.convert: time 0.00854/0.4935, allocations: 3.805 MB / 0.67 GB, free: 2.023 MB / 0.4981 GB
Notification: Performance of FrontEnd - DAE generated: time 9.497e-06/0.4935, allocations: 0 / 0.67 GB, free: 2.023 MB / 0.4981 GB
Notification: Performance of FrontEnd: time 3.607e-06/0.4935, allocations: 7.922 kB / 0.67 GB, free: 2.016 MB / 0.4981 GB
Notification: Performance of Transformations before backend: time 0.000135/0.4937, allocations: 0 / 0.67 GB, free: 2.016 MB / 0.4981 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 282
 * Number of variables: 282
Notification: Performance of Generate backend data structure: time 0.006833/0.5005, allocations: 2.909 MB / 0.6728 GB, free: 15.03 MB / 0.5137 GB
Notification: Performance of prepare preOptimizeDAE: time 4.555e-05/0.5006, allocations: 12.62 kB / 0.6729 GB, free: 15.02 MB / 0.5137 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002944/0.5035, allocations: 0.5472 MB / 0.6734 GB, free: 14.46 MB / 0.5137 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.005215/0.5088, allocations: 2.586 MB / 0.6759 GB, free: 11.8 MB / 0.5137 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0004528/0.5092, allocations: 154.1 kB / 0.6761 GB, free: 11.65 MB / 0.5137 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0003408/0.5096, allocations: 120 kB / 0.6762 GB, free: 11.54 MB / 0.5137 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00321/0.5128, allocations: 1.367 MB / 0.6775 GB, free: 10.07 MB / 0.5137 GB
Notification: Performance of preOpt findStateOrder (simulation): time 3.151e-05/0.5129, allocations: 3.938 kB / 0.6775 GB, free: 10.07 MB / 0.5137 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001332/0.513, allocations: 51.98 kB / 0.6776 GB, free: 10.02 MB / 0.5137 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.536e-05/0.5131, allocations: 28 kB / 0.6776 GB, free: 9.988 MB / 0.5137 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003096/0.5162, allocations: 1.109 MB / 0.6787 GB, free: 8.871 MB / 0.5137 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.01073/0.5269, allocations: 7.507 MB / 0.686 GB, free: 0.7773 MB / 0.5137 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002871/0.5298, allocations: 1.385 MB / 0.6874 GB, free: 15.28 MB / 0.5294 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001082/0.5309, allocations: 430.2 kB / 0.6878 GB, free: 14.85 MB / 0.5294 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.005168/0.5361, allocations: 3.047 MB / 0.6907 GB, free: 11.46 MB / 0.5294 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.001186/0.5373, allocations: 442.8 kB / 0.6912 GB, free: 11.02 MB / 0.5294 GB
Notification: Performance of pre-optimization done (n=57): time 2.946e-06/0.5373, allocations: 0 / 0.6912 GB, free: 11.02 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=57): time 0.003755/0.5411, allocations: 1.279 MB / 0.6924 GB, free: 9.707 MB / 0.5294 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.842e-05/0.5411, allocations: 59.97 kB / 0.6925 GB, free: 9.637 MB / 0.5294 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003385/0.5445, allocations: 2.097 MB / 0.6945 GB, free: 7.512 MB / 0.5294 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001061/0.5446, allocations: 41.7 kB / 0.6946 GB, free: 7.465 MB / 0.5294 GB
Notification: Performance of collectInitialEqns (initialization): time 0.001032/0.5457, allocations: 1.018 MB / 0.6956 GB, free: 6.438 MB / 0.5294 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002358/0.5459, allocations: 205.1 kB / 0.6957 GB, free: 6.234 MB / 0.5294 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004746/0.5464, allocations: 310.5 kB / 0.696 GB, free: 5.922 MB / 0.5294 GB
Notification: Performance of setup shared object (initialization): time 0.000118/0.5465, allocations: 305.1 kB / 0.6963 GB, free: 5.621 MB / 0.5294 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001341/0.5479, allocations: 0.561 MB / 0.6969 GB, free: 5.059 MB / 0.5294 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.001728/0.5496, allocations: 1.004 MB / 0.6979 GB, free: 3.871 MB / 0.5294 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.002783/0.5524, allocations: 1.455 MB / 0.6993 GB, free: 2.246 MB / 0.5294 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.126e-05/0.5524, allocations: 4 kB / 0.6993 GB, free: 2.242 MB / 0.5294 GB
Notification: Performance of matching and sorting (n=185) (initialization): time 0.003932/0.5564, allocations: 1.775 MB / 0.701 GB, free: 464 kB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 5.183e-05/0.5565, allocations: 37.7 kB / 0.7011 GB, free: 420 kB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.358e-05/0.5565, allocations: 12 kB / 0.7011 GB, free: 408 kB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 3.234e-05/0.5565, allocations: 16 kB / 0.7011 GB, free: 392 kB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001199/0.5577, allocations: 315.9 kB / 0.7014 GB, free: 76 kB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.452e-05/0.5578, allocations: 23.92 kB / 0.7014 GB, free: 52 kB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00167/0.5595, allocations: 195 kB / 0.7016 GB, free: 15.86 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001279/0.5596, allocations: 55.98 kB / 0.7016 GB, free: 15.8 MB / 0.545 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002084/0.5617, allocations: 0.9788 MB / 0.7026 GB, free: 14.82 MB / 0.545 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001723/0.5634, allocations: 1.004 MB / 0.7036 GB, free: 13.63 MB / 0.545 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.002828/0.5663, allocations: 1.454 MB / 0.705 GB, free: 12.01 MB / 0.545 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.446e-05/0.5663, allocations: 11.94 kB / 0.705 GB, free: 12 MB / 0.545 GB
Notification: Performance of matching and sorting (n=185) (initialization_lambda0): time 0.004279/0.5706, allocations: 1.765 MB / 0.7067 GB, free: 10.21 MB / 0.545 GB
Notification: Performance of prepare postOptimizeDAE: time 5.577e-05/0.5707, allocations: 43.88 kB / 0.7068 GB, free: 10.16 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.119e-05/0.5707, allocations: 15.94 kB / 0.7068 GB, free: 10.15 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.59e-05/0.5707, allocations: 20 kB / 0.7068 GB, free: 10.13 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001171/0.5719, allocations: 308.1 kB / 0.7071 GB, free: 9.828 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 3.347e-05/0.5719, allocations: 19.94 kB / 0.7071 GB, free: 9.809 MB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001758/0.5737, allocations: 171.8 kB / 0.7073 GB, free: 9.641 MB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.000151/0.5739, allocations: 75.97 kB / 0.7074 GB, free: 9.566 MB / 0.545 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 53
 * Number of states: 0 ()
 * Number of discrete variables: 6 (TSet.count,$PRE.TSet.count,TSet.T_start,$PRE.TSet.T_start,$whenCondition1,conPI.I.trigger_internal)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (151):
 * Single equations (assignments): 148
 * Array equations: 1
 * Algorithm blocks: 1
 * Record equations: 1
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0003969/0.5743, allocations: 259.8 kB / 0.7076 GB, free: 9.305 MB / 0.545 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006182/0.5749, allocations: 201.4 kB / 0.7078 GB, free: 9.105 MB / 0.545 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003321/0.5782, allocations: 1.146 MB / 0.7089 GB, free: 7.949 MB / 0.545 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.775e-05/0.5783, allocations: 8 kB / 0.7089 GB, free: 7.941 MB / 0.545 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.925e-06/0.5783, allocations: 0 / 0.7089 GB, free: 7.941 MB / 0.545 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002286/0.5806, allocations: 0.9776 MB / 0.7099 GB, free: 6.914 MB / 0.545 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.006882/0.5875, allocations: 2.573 MB / 0.7124 GB, free: 4.27 MB / 0.545 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.722e-06/0.5875, allocations: 64 / 0.7124 GB, free: 4.27 MB / 0.545 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007793/0.5883, allocations: 151.8 kB / 0.7125 GB, free: 4.121 MB / 0.545 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0002148/0.5885, allocations: 44.77 kB / 0.7126 GB, free: 4.074 MB / 0.545 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 6.394e-05/0.5886, allocations: 15.98 kB / 0.7126 GB, free: 4.059 MB / 0.545 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001485/0.5901, allocations: 1.488 MB / 0.7141 GB, free: 2.434 MB / 0.545 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.535e-06/0.5901, allocations: 0 / 0.7141 GB, free: 2.434 MB / 0.545 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.004517/0.5946, allocations: 1.581 MB / 0.7156 GB, free: 0.8281 MB / 0.545 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00127/0.5959, allocations: 394 kB / 0.716 GB, free: 432 kB / 0.545 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0006582/0.5966, allocations: 16 kB / 0.716 GB, free: 416 kB / 0.545 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001338/0.5979, allocations: 71.92 kB / 0.7161 GB, free: 344 kB / 0.545 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001506/0.5981, allocations: 52.48 kB / 0.7161 GB, free: 292 kB / 0.545 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.948e-05/0.5982, allocations: 31.97 kB / 0.7161 GB, free: 260 kB / 0.545 GB
Notification: Performance of sorting global known variables: time 0.00309/0.6013, allocations: 1.453 MB / 0.7176 GB, free: 14.79 MB / 0.5606 GB
Notification: Performance of sort global known variables: time 1.61e-07/0.6013, allocations: 0 / 0.7176 GB, free: 14.79 MB / 0.5606 GB
Notification: Performance of remove unused functions: time 0.003319/0.6046, allocations: 1.018 MB / 0.7185 GB, free: 13.77 MB / 0.5606 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 3
 * Number of states: 5 (vol.dynBal.U,mov.motSpe.y,conPI.I.y,THeaOut.T,coo.outCon.T)
 * Number of discrete variables: 3 ($whenCondition1,TSet.T_start,TSet.count)
 * Number of discrete states: 1 (TSet.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (66):
 * Single equations (assignments): 57
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 6
 * When equations: 2
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 1 system
   {(1,2,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 0 systems
Notification: Performance of Backend phase and start with SimCode phase: time 0.002705/0.6074, allocations: 0.8684 MB / 0.7194 GB, free: 13.06 MB / 0.5606 GB
Notification: Performance of simCode: created initialization part: time 0.00526/0.6126, allocations: 2.171 MB / 0.7215 GB, free: 10.88 MB / 0.5606 GB
Notification: Performance of simCode: created event and clocks part: time 5.1e-06/0.6127, allocations: 0 / 0.7215 GB, free: 10.88 MB / 0.5606 GB
Notification: Performance of simCode: created simulation system equations: time 0.001474/0.6141, allocations: 0.5529 MB / 0.7221 GB, free: 10.31 MB / 0.5606 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00459/0.6187, allocations: 0.9667 MB / 0.723 GB, free: 9.391 MB / 0.5606 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007237/0.626, allocations: 3.656 MB / 0.7266 GB, free: 5.699 MB / 0.5606 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001509/0.6275, allocations: 1.531 MB / 0.7281 GB, free: 4.137 MB / 0.5606 GB
Notification: Performance of simCode: alias equations: time 0.002279/0.6298, allocations: 0.5082 MB / 0.7286 GB, free: 3.625 MB / 0.5606 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005298/0.6304, allocations: 163.4 kB / 0.7287 GB, free: 3.465 MB / 0.5606 GB
Notification: Performance of SimCode: time 8.31e-07/0.6304, allocations: 0 / 0.7287 GB, free: 3.465 MB / 0.5606 GB
Notification: Performance of Templates: time 0.3215/0.9519, allocations: 39.22 MB / 0.767 GB, free: 149.2 MB / 0.5762 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.sim & ./IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.pipe 2>&1)