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.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.001755/0.001755, allocations: 92.72 kB / 20.21 MB, free: 4.223 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.002259/0.002259, allocations: 157.7 kB / 23.52 MB, free: 0.918 MB / 18.57 MB " [Timeout remaining time 180] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 1.464/1.464, allocations: 177.2 MB / 203.9 MB, free: 5.566 MB / 186.7 MB " [Timeout remaining time 178] loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo", uses=false) [Timeout 180] "Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo): time 0.9531/0.9531, allocations: 115 MB / 375.3 MB, free: 7.551 MB / 346.7 MB " [Timeout remaining time 179] Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA master/package.mo) Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo) Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo) Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo) Running command: translateModel(IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T") translateModel(IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T,tolerance=1e-08,outputFormat="empty",numberOfIntervals=2500,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T") [Timeout 660] "Notification: Performance of FrontEnd - loaded program: time 1.623e-06/1.623e-06, allocations: 0 / 480.8 MB, free: 11.89 MB / 410.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 2.515e-05/2.677e-05, allocations: 4.984 kB / 480.8 MB, free: 11.89 MB / 410.7 MB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T): time 0.06254/0.06256, allocations: 49.33 MB / 0.5177 GB, free: 7.035 MB / 442.7 MB Notification: Performance of NFInst.instExpressions: time 0.03442/0.09698, allocations: 16.82 MB / 0.5341 GB, free: 6.172 MB / 458.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.003624/0.1006, allocations: 134.9 kB / 0.5343 GB, free: 6.039 MB / 458.7 MB Notification: Performance of NFTyping.typeComponents: time 0.006392/0.107, allocations: 1.939 MB / 0.5362 GB, free: 4.09 MB / 458.7 MB Notification: Performance of NFTyping.typeBindings: time 0.008597/0.1156, allocations: 2.77 MB / 0.5389 GB, free: 1.305 MB / 458.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.007991/0.1236, allocations: 2.817 MB / 0.5416 GB, free: 14.48 MB / 474.7 MB Notification: Performance of NFFlatten.flatten: time 0.0148/0.1384, allocations: 8.501 MB / 0.5499 GB, free: 5.957 MB / 474.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.003117/0.1415, allocations: 1.403 MB / 0.5513 GB, free: 4.52 MB / 474.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.008389/0.1499, allocations: 3.165 MB / 0.5544 GB, free: 1.367 MB / 474.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.002982/0.1529, allocations: 1.25 MB / 0.5556 GB, free: 116 kB / 474.7 MB Notification: Performance of NFPackage.collectConstants: time 0.0006151/0.1535, allocations: 172 kB / 0.5558 GB, free: 15.94 MB / 490.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.003726/0.1572, allocations: 1.423 MB / 0.5571 GB, free: 14.52 MB / 490.7 MB Notification: Performance of NFScalarize.scalarize: time 0.000962/0.1582, allocations: 0.6966 MB / 0.5578 GB, free: 13.82 MB / 490.7 MB Notification: Performance of NFVerifyModel.verify: time 0.00165/0.1598, allocations: 0.7908 MB / 0.5586 GB, free: 13.03 MB / 490.7 MB Notification: Performance of NFConvertDAE.convert: time 0.007188/0.167, allocations: 3.754 MB / 0.5623 GB, free: 9.262 MB / 490.7 MB Notification: Performance of FrontEnd - DAE generated: time 5.371e-06/0.167, allocations: 3.938 kB / 0.5623 GB, free: 9.258 MB / 490.7 MB Notification: Performance of FrontEnd: time 1.592e-06/0.167, allocations: 0 / 0.5623 GB, free: 9.258 MB / 490.7 MB Notification: Performance of Transformations before backend: time 9.091e-05/0.1671, allocations: 4 kB / 0.5623 GB, free: 9.254 MB / 490.7 MB 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.006622/0.1737, allocations: 2.947 MB / 0.5652 GB, free: 6.242 MB / 490.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.692e-05/0.1738, allocations: 12.03 kB / 0.5652 GB, free: 6.23 MB / 490.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.03036/0.2041, allocations: 4.458 MB / 0.5695 GB, free: 1.766 MB / 490.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.007378/0.2115, allocations: 3.076 MB / 0.5725 GB, free: 14.61 MB / 0.4948 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001575/0.2117, allocations: 98.16 kB / 0.5726 GB, free: 14.51 MB / 0.4948 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004719/0.2122, allocations: 128 kB / 0.5727 GB, free: 14.39 MB / 0.4948 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.01296/0.2251, allocations: 2.883 MB / 0.5756 GB, free: 11.37 MB / 0.4948 GB Notification: Performance of preOpt findStateOrder (simulation): time 5.91e-05/0.2252, allocations: 4 kB / 0.5756 GB, free: 11.36 MB / 0.4948 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002738/0.2254, allocations: 48 kB / 0.5756 GB, free: 11.32 MB / 0.4948 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.295e-05/0.2255, allocations: 35.92 kB / 0.5756 GB, free: 11.28 MB / 0.4948 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01979/0.2453, allocations: 3.723 MB / 0.5793 GB, free: 7.547 MB / 0.4948 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.03336/0.2786, allocations: 9.706 MB / 0.5887 GB, free: 13.18 MB / 0.5105 GB Notification: Performance of preOpt comSubExp (simulation): time 0.01137/0.29, allocations: 2.218 MB / 0.5909 GB, free: 10.96 MB / 0.5105 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.01009/0.3001, allocations: 1.759 MB / 0.5926 GB, free: 9.191 MB / 0.5105 GB Notification: Performance of preOpt evalFunc (simulation): time 0.008588/0.3087, allocations: 3.553 MB / 0.5961 GB, free: 5.129 MB / 0.5105 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0108/0.3195, allocations: 1.97 MB / 0.598 GB, free: 3.117 MB / 0.5105 GB Notification: Performance of pre-optimization done (n=57): time 4.438e-06/0.3195, allocations: 0 / 0.598 GB, free: 3.117 MB / 0.5105 GB Notification: Performance of matching and sorting (n=57): time 0.02955/0.349, allocations: 5.171 MB / 0.6031 GB, free: 13.93 MB / 0.5261 GB Notification: Performance of inlineWhenForInitialization (initialization): time 7.612e-05/0.3491, allocations: 67.89 kB / 0.6031 GB, free: 13.86 MB / 0.5261 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.004807/0.3539, allocations: 2.079 MB / 0.6052 GB, free: 11.75 MB / 0.5261 GB Notification: Performance of collectPreVariables (initialization): time 0.0002711/0.3542, allocations: 41.7 kB / 0.6052 GB, free: 11.71 MB / 0.5261 GB Notification: Performance of collectInitialEqns (initialization): time 0.001488/0.3557, allocations: 1.107 MB / 0.6063 GB, free: 10.59 MB / 0.5261 GB Notification: Performance of collectInitialBindings (initialization): time 0.0004401/0.3561, allocations: 210.2 kB / 0.6065 GB, free: 10.38 MB / 0.5261 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0006419/0.3568, allocations: 234.8 kB / 0.6067 GB, free: 10.15 MB / 0.5261 GB Notification: Performance of setup shared object (initialization): time 0.0002318/0.357, allocations: 345.9 kB / 0.607 GB, free: 9.805 MB / 0.5261 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.009602/0.3666, allocations: 1.775 MB / 0.6088 GB, free: 8.02 MB / 0.5261 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.01046/0.3771, allocations: 2.497 MB / 0.6112 GB, free: 5.223 MB / 0.5261 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.01784/0.3949, allocations: 3.619 MB / 0.6148 GB, free: 1.387 MB / 0.5261 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.068e-05/0.3949, allocations: 4 kB / 0.6148 GB, free: 1.383 MB / 0.5261 GB Notification: Performance of matching and sorting (n=136) (initialization): time 0.02003/0.415, allocations: 4.071 MB / 0.6187 GB, free: 13.29 MB / 0.5417 GB Notification: Performance of prepare postOptimizeDAE: time 7.246e-05/0.415, allocations: 45.73 kB / 0.6188 GB, free: 13.24 MB / 0.5417 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.371e-05/0.4151, allocations: 16 kB / 0.6188 GB, free: 13.22 MB / 0.5417 GB Notification: Performance of postOpt tearingSystem (initialization): time 4.901e-05/0.4151, allocations: 23.98 kB / 0.6188 GB, free: 13.2 MB / 0.5417 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005834/0.4209, allocations: 0.9089 MB / 0.6197 GB, free: 12.29 MB / 0.5417 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.563e-05/0.421, allocations: 35.92 kB / 0.6197 GB, free: 12.25 MB / 0.5417 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006181/0.4272, allocations: 0.7913 MB / 0.6205 GB, free: 11.46 MB / 0.5417 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002359/0.4274, allocations: 67.97 kB / 0.6206 GB, free: 11.39 MB / 0.5417 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01024/0.4376, allocations: 2.186 MB / 0.6227 GB, free: 9.199 MB / 0.5417 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01026/0.4479, allocations: 2.497 MB / 0.6251 GB, free: 6.406 MB / 0.5417 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01713/0.465, allocations: 3.611 MB / 0.6287 GB, free: 2.57 MB / 0.5417 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.427e-05/0.4651, allocations: 8 kB / 0.6287 GB, free: 2.562 MB / 0.5417 GB Notification: Performance of matching and sorting (n=136) (initialization_lambda0): time 0.01942/0.4845, allocations: 4.07 MB / 0.6327 GB, free: 14.47 MB / 0.5573 GB Notification: Performance of prepare postOptimizeDAE: time 7.169e-05/0.4846, allocations: 41.7 kB / 0.6327 GB, free: 14.42 MB / 0.5573 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.164e-05/0.4846, allocations: 19.94 kB / 0.6327 GB, free: 14.4 MB / 0.5573 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.519e-05/0.4846, allocations: 20 kB / 0.6327 GB, free: 14.38 MB / 0.5573 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005631/0.4902, allocations: 0.9017 MB / 0.6336 GB, free: 13.48 MB / 0.5573 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.456e-05/0.4903, allocations: 35.91 kB / 0.6336 GB, free: 13.45 MB / 0.5573 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.006244/0.4965, allocations: 0.776 MB / 0.6344 GB, free: 12.67 MB / 0.5573 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002177/0.4967, allocations: 67.97 kB / 0.6345 GB, free: 12.6 MB / 0.5573 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 69 * 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 (134): * Single equations (assignments): 132 * Array equations: 1 * Algorithm blocks: 1 * Record equations: 0 * 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.0004827/0.4972, allocations: 263.8 kB / 0.6347 GB, free: 12.34 MB / 0.5573 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0006993/0.4979, allocations: 238.5 kB / 0.6349 GB, free: 12.1 MB / 0.5573 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01947/0.5174, allocations: 3.816 MB / 0.6387 GB, free: 8.281 MB / 0.5573 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 3.122e-05/0.5174, allocations: 8 kB / 0.6387 GB, free: 8.273 MB / 0.5573 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 9.037e-06/0.5174, allocations: 0 / 0.6387 GB, free: 8.273 MB / 0.5573 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.01819/0.5356, allocations: 3.542 MB / 0.6421 GB, free: 4.676 MB / 0.5573 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.2109/0.7465, allocations: 5.575 MB / 0.6476 GB, free: 167.3 MB / 0.5573 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.059e-05/0.7465, allocations: 4.312 kB / 0.6476 GB, free: 167.3 MB / 0.5573 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.005152/0.7516, allocations: 0.7672 MB / 0.6483 GB, free: 167.3 MB / 0.5573 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0002388/0.7519, allocations: 38.84 kB / 0.6484 GB, free: 167.3 MB / 0.5573 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0001474/0.752, allocations: 24.3 kB / 0.6484 GB, free: 167.3 MB / 0.5573 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0009738/0.753, allocations: 1.354 MB / 0.6497 GB, free: 166.2 MB / 0.5573 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.115e-06/0.753, allocations: 3.656 kB / 0.6497 GB, free: 166.2 MB / 0.5573 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.02564/0.7787, allocations: 5.68 MB / 0.6553 GB, free: 165.5 MB / 0.5573 GB Notification: Performance of postOpt removeConstants (simulation): time 0.000995/0.7796, allocations: 379 kB / 0.6556 GB, free: 165.4 MB / 0.5573 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0004457/0.7801, allocations: 10.88 kB / 0.6556 GB, free: 165.4 MB / 0.5573 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.005184/0.7853, allocations: 0.6894 MB / 0.6563 GB, free: 165.3 MB / 0.5573 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001502/0.7854, allocations: 49.77 kB / 0.6564 GB, free: 165.3 MB / 0.5573 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001342/0.7856, allocations: 41.5 kB / 0.6564 GB, free: 165.3 MB / 0.5573 GB Notification: Performance of sorting global known variables: time 0.002049/0.7876, allocations: 1.389 MB / 0.6578 GB, free: 164.8 MB / 0.5573 GB Notification: Performance of sort global known variables: time 8e-08/0.7876, allocations: 7.844 kB / 0.6578 GB, free: 164.8 MB / 0.5573 GB Notification: Performance of remove unused functions: time 0.002878/0.7905, allocations: 1.002 MB / 0.6587 GB, free: 164.7 MB / 0.5573 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.002385/0.7929, allocations: 0.6808 MB / 0.6594 GB, free: 164.6 MB / 0.5573 GB Notification: Performance of simCode: created initialization part: time 0.0259/0.8188, allocations: 5.785 MB / 0.6651 GB, free: 163.3 MB / 0.5573 GB Notification: Performance of simCode: created event and clocks part: time 4.819e-06/0.8188, allocations: 5 kB / 0.6651 GB, free: 163.3 MB / 0.5573 GB Notification: Performance of simCode: created simulation system equations: time 0.008718/0.8275, allocations: 1.917 MB / 0.6669 GB, free: 162.8 MB / 0.5573 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004462/0.832, allocations: 1.056 MB / 0.668 GB, free: 162.5 MB / 0.5573 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01422/0.8462, allocations: 5.069 MB / 0.6729 GB, free: 160.4 MB / 0.5573 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001371/0.8475, allocations: 0.9789 MB / 0.6739 GB, free: 160.1 MB / 0.5573 GB Notification: Performance of simCode: alias equations: time 0.003006/0.8505, allocations: 0.5757 MB / 0.6744 GB, free: 159.9 MB / 0.5573 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0008651/0.8514, allocations: 185.3 kB / 0.6746 GB, free: 159.9 MB / 0.5573 GB Notification: Performance of SimCode: time 1.372e-06/0.8514, allocations: 0 / 0.6746 GB, free: 159.9 MB / 0.5573 GB Notification: Performance of Templates: time 0.05651/0.9079, allocations: 43.16 MB / 0.7168 GB, free: 124.5 MB / 0.5573 GB " [Timeout remaining time 659] make -j1 -f IBPSA_latest_IBPSA.Fluid.HeatExchangers.Examples.WaterCooler_T.makefile [Timeout 660] (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) [Timeout 480] [Calling sys.exit(0), Time elapsed: 7.472577342065051]