Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_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/IDEAS 3.0.0-master/package.mo", uses=false) Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.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(IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T") translateModel(IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001201/0.001201, allocations: 118.5 kB / 16.37 MB, free: 6.004 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.001198/0.001198, allocations: 192.8 kB / 17.31 MB, free: 5.613 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.28/1.28, allocations: 222.9 MB / 241 MB, free: 15.17 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0-master/package.mo): time 0.7849/0.7849, allocations: 135.1 MB / 426.3 MB, free: 4.133 MB / 334.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001192/0.001192, allocations: 63.84 kB / 0.5068 GB, free: 7.668 MB / 430.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.362/0.3632, allocations: 80.9 MB / 0.5858 GB, free: 25.54 MB / 446.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T): time 0.043/0.4063, allocations: 53.26 MB / 0.6378 GB, free: 5.18 MB / 478.1 MB Notification: Performance of NFInst.instExpressions: time 0.02249/0.4288, allocations: 15.2 MB / 0.6526 GB, free: 5.941 MB / 494.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.002758/0.4316, allocations: 87.5 kB / 0.6527 GB, free: 5.855 MB / 494.1 MB Notification: Performance of NFTyping.typeComponents: time 0.002876/0.4345, allocations: 1.114 MB / 0.6538 GB, free: 4.746 MB / 494.1 MB Notification: Performance of NFTyping.typeBindings: time 0.005639/0.4402, allocations: 2.341 MB / 0.6561 GB, free: 2.398 MB / 494.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.004938/0.4451, allocations: 2.263 MB / 0.6583 GB, free: 156 kB / 494.1 MB Notification: Performance of NFFlatten.flatten: time 0.005379/0.4505, allocations: 4.633 MB / 0.6628 GB, free: 11.5 MB / 0.4981 GB Notification: Performance of NFFlatten.resolveConnections: time 0.00197/0.4525, allocations: 1.627 MB / 0.6644 GB, free: 9.848 MB / 0.4981 GB Notification: Performance of NFEvalConstants.evaluate: time 0.00344/0.4559, allocations: 1.908 MB / 0.6663 GB, free: 7.938 MB / 0.4981 GB Notification: Performance of NFSimplifyModel.simplify: time 0.001523/0.4575, allocations: 1.353 MB / 0.6676 GB, free: 6.578 MB / 0.4981 GB Notification: Performance of NFPackage.collectConstants: time 0.0002209/0.4577, allocations: 168 kB / 0.6677 GB, free: 6.414 MB / 0.4981 GB Notification: Performance of NFFlatten.collectFunctions: time 0.003096/0.4608, allocations: 1.845 MB / 0.6695 GB, free: 4.566 MB / 0.4981 GB Notification: Performance of NFScalarize.scalarize: time 0.0004644/0.4613, allocations: 0.5177 MB / 0.67 GB, free: 4.047 MB / 0.4981 GB Notification: Performance of NFVerifyModel.verify: time 0.000925/0.4622, allocations: 1.034 MB / 0.6711 GB, free: 3.008 MB / 0.4981 GB Notification: Performance of NFConvertDAE.convert: time 0.003707/0.4659, allocations: 3.322 MB / 0.6743 GB, free: 15.68 MB / 0.5137 GB Notification: Performance of FrontEnd - DAE generated: time 5.18e-06/0.4659, allocations: 3.984 kB / 0.6743 GB, free: 15.67 MB / 0.5137 GB Notification: Performance of FrontEnd: time 1.543e-06/0.466, allocations: 0 / 0.6743 GB, free: 15.67 MB / 0.5137 GB Notification: Performance of Transformations before backend: time 2.592e-05/0.466, allocations: 0 / 0.6743 GB, free: 15.67 MB / 0.5137 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 281 * Number of variables: 281 Notification: Performance of Generate backend data structure: time 0.003744/0.4697, allocations: 2.525 MB / 0.6768 GB, free: 13.08 MB / 0.5137 GB Notification: Performance of prepare preOptimizeDAE: time 3.689e-05/0.4698, allocations: 13.05 kB / 0.6768 GB, free: 13.07 MB / 0.5137 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001869/0.4717, allocations: 449.5 kB / 0.6772 GB, free: 12.62 MB / 0.5137 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.003185/0.4749, allocations: 1.676 MB / 0.6788 GB, free: 10.9 MB / 0.5137 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 7.816e-05/0.475, allocations: 94.19 kB / 0.6789 GB, free: 10.8 MB / 0.5137 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002046/0.4752, allocations: 127.9 kB / 0.6791 GB, free: 10.68 MB / 0.5137 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002529/0.4777, allocations: 1.343 MB / 0.6804 GB, free: 9.242 MB / 0.5137 GB Notification: Performance of preOpt findStateOrder (simulation): time 2.736e-05/0.4777, allocations: 0 / 0.6804 GB, free: 9.242 MB / 0.5137 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001086/0.4779, allocations: 48 kB / 0.6804 GB, free: 9.195 MB / 0.5137 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 7.099e-05/0.4779, allocations: 49.98 kB / 0.6805 GB, free: 9.145 MB / 0.5137 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002523/0.4805, allocations: 1.07 MB / 0.6815 GB, free: 8.066 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.009659/0.4901, allocations: 7.083 MB / 0.6884 GB, free: 444 kB / 0.5137 GB Notification: Performance of preOpt comSubExp (simulation): time 0.002268/0.4924, allocations: 1.35 MB / 0.6897 GB, free: 14.96 MB / 0.5294 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.0009003/0.4933, allocations: 421.5 kB / 0.6901 GB, free: 14.55 MB / 0.5294 GB Notification: Performance of preOpt evalFunc (simulation): time 0.005171/0.4985, allocations: 3.087 MB / 0.6932 GB, free: 11.13 MB / 0.5294 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0009626/0.4995, allocations: 434.9 kB / 0.6936 GB, free: 10.69 MB / 0.5294 GB Notification: Performance of pre-optimization done (n=60): time 2.345e-06/0.4995, allocations: 0 / 0.6936 GB, free: 10.69 MB / 0.5294 GB Notification: Performance of matching and sorting (n=60): time 0.002828/0.5023, allocations: 1.209 MB / 0.6948 GB, free: 9.449 MB / 0.5294 GB Notification: Performance of inlineWhenForInitialization (initialization): time 4.893e-05/0.5024, allocations: 63.95 kB / 0.6948 GB, free: 9.375 MB / 0.5294 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001904/0.5043, allocations: 1.537 MB / 0.6963 GB, free: 7.836 MB / 0.5294 GB Notification: Performance of collectPreVariables (initialization): time 6.434e-05/0.5044, allocations: 41.64 kB / 0.6964 GB, free: 7.789 MB / 0.5294 GB Notification: Performance of collectInitialEqns (initialization): time 0.0006839/0.5051, allocations: 0.8839 MB / 0.6972 GB, free: 6.895 MB / 0.5294 GB Notification: Performance of collectInitialBindings (initialization): time 0.0001799/0.5053, allocations: 216.9 kB / 0.6974 GB, free: 6.68 MB / 0.5294 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002983/0.5056, allocations: 202.4 kB / 0.6976 GB, free: 6.477 MB / 0.5294 GB Notification: Performance of setup shared object (initialization): time 0.0001369/0.5057, allocations: 341.9 kB / 0.6979 GB, free: 6.137 MB / 0.5294 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0008755/0.5066, allocations: 376.6 kB / 0.6983 GB, free: 5.766 MB / 0.5294 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001175/0.5078, allocations: 0.7514 MB / 0.699 GB, free: 4.84 MB / 0.5294 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.002035/0.5098, allocations: 1.117 MB / 0.7001 GB, free: 3.562 MB / 0.5294 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.642e-06/0.5098, allocations: 4 kB / 0.7001 GB, free: 3.559 MB / 0.5294 GB Notification: Performance of matching and sorting (n=122) (initialization): time 0.002528/0.5124, allocations: 1.298 MB / 0.7014 GB, free: 2.246 MB / 0.5294 GB Notification: Performance of prepare postOptimizeDAE: time 4.03e-05/0.5124, allocations: 37.7 kB / 0.7014 GB, free: 2.203 MB / 0.5294 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.558e-05/0.5125, allocations: 12 kB / 0.7014 GB, free: 2.191 MB / 0.5294 GB Notification: Performance of postOpt tearingSystem (initialization): time 2.651e-05/0.5125, allocations: 16 kB / 0.7015 GB, free: 2.176 MB / 0.5294 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009886/0.5135, allocations: 255.8 kB / 0.7017 GB, free: 1.926 MB / 0.5294 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.465e-05/0.5135, allocations: 27.86 kB / 0.7017 GB, free: 1.898 MB / 0.5294 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001005/0.5145, allocations: 135.6 kB / 0.7019 GB, free: 1.766 MB / 0.5294 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 9.169e-05/0.5146, allocations: 55.98 kB / 0.7019 GB, free: 1.711 MB / 0.5294 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.001319/0.516, allocations: 0.6658 MB / 0.7026 GB, free: 1.039 MB / 0.5294 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001088/0.5171, allocations: 0.7359 MB / 0.7033 GB, free: 136 kB / 0.5294 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001894/0.519, allocations: 1.085 MB / 0.7043 GB, free: 14.89 MB / 0.545 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.847e-06/0.519, allocations: 0 / 0.7043 GB, free: 14.89 MB / 0.545 GB Notification: Performance of matching and sorting (n=122) (initialization_lambda0): time 0.002428/0.5214, allocations: 1.258 MB / 0.7056 GB, free: 13.61 MB / 0.545 GB Notification: Performance of prepare postOptimizeDAE: time 3.668e-05/0.5215, allocations: 45.69 kB / 0.7056 GB, free: 13.56 MB / 0.545 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.999e-06/0.5215, allocations: 8 kB / 0.7056 GB, free: 13.55 MB / 0.545 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.425e-05/0.5215, allocations: 20.62 kB / 0.7056 GB, free: 13.54 MB / 0.545 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0009314/0.5224, allocations: 251.6 kB / 0.7059 GB, free: 13.29 MB / 0.545 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.763e-05/0.5225, allocations: 19.94 kB / 0.7059 GB, free: 13.27 MB / 0.545 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009325/0.5234, allocations: 120 kB / 0.706 GB, free: 13.15 MB / 0.545 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.142e-05/0.5235, allocations: 51.98 kB / 0.7061 GB, free: 13.1 MB / 0.545 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 49 * 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 (120): * Single equations (assignments): 118 * 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.0002427/0.5237, allocations: 251.8 kB / 0.7063 GB, free: 12.85 MB / 0.545 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002132/0.524, allocations: 165.9 kB / 0.7065 GB, free: 12.68 MB / 0.545 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002473/0.5264, allocations: 1.114 MB / 0.7076 GB, free: 11.57 MB / 0.545 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.454e-05/0.5265, allocations: 8 kB / 0.7076 GB, free: 11.56 MB / 0.545 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.871e-06/0.5265, allocations: 4 kB / 0.7076 GB, free: 11.55 MB / 0.545 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001812/0.5283, allocations: 0.951 MB / 0.7085 GB, free: 10.55 MB / 0.545 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004141/0.5324, allocations: 2.409 MB / 0.7108 GB, free: 8.07 MB / 0.545 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.6e-06/0.5325, allocations: 3.938 kB / 0.7108 GB, free: 8.066 MB / 0.545 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0007051/0.5332, allocations: 147.8 kB / 0.711 GB, free: 7.922 MB / 0.545 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0001534/0.5333, allocations: 28.84 kB / 0.711 GB, free: 7.891 MB / 0.545 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.394e-05/0.5334, allocations: 19.98 kB / 0.711 GB, free: 7.871 MB / 0.545 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001041/0.5344, allocations: 1.426 MB / 0.7124 GB, free: 6.305 MB / 0.545 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.643e-06/0.5345, allocations: 0 / 0.7124 GB, free: 6.305 MB / 0.545 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002962/0.5374, allocations: 1.531 MB / 0.7139 GB, free: 4.754 MB / 0.545 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0005815/0.538, allocations: 354.5 kB / 0.7143 GB, free: 4.387 MB / 0.545 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001874/0.5382, allocations: 12 kB / 0.7143 GB, free: 4.375 MB / 0.545 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0008135/0.539, allocations: 63.81 kB / 0.7143 GB, free: 4.312 MB / 0.545 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001286/0.5392, allocations: 52.5 kB / 0.7144 GB, free: 4.262 MB / 0.545 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.188e-05/0.5393, allocations: 27.97 kB / 0.7144 GB, free: 4.234 MB / 0.545 GB Notification: Performance of sorting global known variables: time 0.001533/0.5408, allocations: 1.097 MB / 0.7155 GB, free: 3.113 MB / 0.545 GB Notification: Performance of sort global known variables: time 2.4e-07/0.5408, allocations: 0 / 0.7155 GB, free: 3.113 MB / 0.545 GB Notification: Performance of remove unused functions: time 0.00208/0.5429, allocations: 0.8537 MB / 0.7163 GB, free: 2.258 MB / 0.545 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 3 * Number of states: 6 (vol.dynBal.U,mov.filter.s[1],mov.filter.s[2],conPI.I.y,THeaOut.T,hea.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 (70): * Single equations (assignments): 61 * 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,1,100.0%)} * Non-linear torn systems (#iteration vars, #inner vars): 0 systems Notification: Performance of Backend phase and start with SimCode phase: time 0.001551/0.5445, allocations: 0.7402 MB / 0.717 GB, free: 1.68 MB / 0.545 GB Notification: Performance of simCode: created initialization part: time 0.003237/0.5477, allocations: 1.574 MB / 0.7186 GB, free: 84 kB / 0.545 GB Notification: Performance of simCode: created event and clocks part: time 2.755e-06/0.5477, allocations: 4.25 kB / 0.7186 GB, free: 80 kB / 0.545 GB Notification: Performance of simCode: created simulation system equations: time 0.001127/0.5489, allocations: 0.541 MB / 0.7191 GB, free: 15.52 MB / 0.5606 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002697/0.5516, allocations: 0.7588 MB / 0.7198 GB, free: 14.78 MB / 0.5606 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004676/0.5563, allocations: 3.035 MB / 0.7228 GB, free: 11.71 MB / 0.5606 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008702/0.5571, allocations: 1.356 MB / 0.7241 GB, free: 10.33 MB / 0.5606 GB Notification: Performance of simCode: alias equations: time 0.001294/0.5584, allocations: 414 kB / 0.7245 GB, free: 9.918 MB / 0.5606 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003179/0.5588, allocations: 135.4 kB / 0.7247 GB, free: 9.785 MB / 0.5606 GB Notification: Performance of SimCode: time 5.01e-07/0.5588, allocations: 3.938 kB / 0.7247 GB, free: 9.781 MB / 0.5606 GB Notification: Performance of Templates: time 0.3003/0.8591, allocations: 31.46 MB / 0.7554 GB, free: 153.2 MB / 0.5762 GB make -j1 -f IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T.makefile (rm -f IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T.sim & ./IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T -abortSlowSimulation -alarm=480 -s cvode -lv LOG_STATS > IDEAS_dev_IDEAS.Fluid.HeatExchangers.Examples.WaterHeater_T.pipe 2>&1)