Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater.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/package.mo", uses=false) Using package IDEAS with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/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.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater") translateModel(IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001598/0.001598, allocations: 104.4 kB / 16.35 MB, free: 6.289 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.001883/0.001883, allocations: 192.7 kB / 17.29 MB, free: 5.863 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.305/1.305, allocations: 222.9 MB / 241 MB, free: 15.15 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS 3.0.0/package.mo): time 0.7887/0.7887, allocations: 132.2 MB / 423.3 MB, free: 6.629 MB / 334.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001476/0.001476, allocations: 67.89 kB / 0.5032 GB, free: 10.95 MB / 430.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3488/0.3503, allocations: 80.18 MB / 0.5815 GB, free: 27.64 MB / 446.1 MB Notification: Performance of NFInst.instantiate(IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater): time 0.01733/0.3677, allocations: 23.36 MB / 0.6043 GB, free: 6.82 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.00777/0.3755, allocations: 6.828 MB / 0.611 GB, free: 12 kB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001019/0.3766, allocations: 35.8 kB / 0.611 GB, free: 15.97 MB / 462.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0009209/0.3775, allocations: 325.8 kB / 0.6113 GB, free: 15.65 MB / 462.1 MB Notification: Performance of NFTyping.typeBindings: time 0.002409/0.38, allocations: 0.906 MB / 0.6122 GB, free: 14.75 MB / 462.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.001991/0.382, allocations: 0.7545 MB / 0.6129 GB, free: 14.01 MB / 462.1 MB Notification: Performance of NFFlatten.flatten: time 0.003771/0.3857, allocations: 3.476 MB / 0.6163 GB, free: 10.53 MB / 462.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.001623/0.3874, allocations: 1.328 MB / 0.6176 GB, free: 9.188 MB / 462.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.002484/0.3899, allocations: 1.203 MB / 0.6188 GB, free: 7.988 MB / 462.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.001212/0.3911, allocations: 0.9334 MB / 0.6197 GB, free: 7.051 MB / 462.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001453/0.3913, allocations: 88 kB / 0.6198 GB, free: 6.965 MB / 462.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.001557/0.3928, allocations: 0.7798 MB / 0.6206 GB, free: 6.184 MB / 462.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0003038/0.3931, allocations: 291 kB / 0.6208 GB, free: 5.898 MB / 462.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0007589/0.3939, allocations: 0.6259 MB / 0.6214 GB, free: 5.27 MB / 462.1 MB Notification: Performance of NFConvertDAE.convert: time 0.002342/0.3963, allocations: 1.903 MB / 0.6233 GB, free: 3.363 MB / 462.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.541e-06/0.3963, allocations: 3.938 kB / 0.6233 GB, free: 3.359 MB / 462.1 MB Notification: Performance of FrontEnd: time 4.809e-06/0.3963, allocations: 0 / 0.6233 GB, free: 3.359 MB / 462.1 MB Notification: Performance of Transformations before backend: time 2.063e-05/0.3963, allocations: 3.938 kB / 0.6233 GB, free: 3.355 MB / 462.1 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 183 * Number of variables: 183 Notification: Performance of Generate backend data structure: time 0.002341/0.3987, allocations: 1.552 MB / 0.6248 GB, free: 1.754 MB / 462.1 MB Notification: Performance of prepare preOptimizeDAE: time 3.638e-05/0.3987, allocations: 12.03 kB / 0.6248 GB, free: 1.742 MB / 462.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004344/0.3992, allocations: 143.4 kB / 0.625 GB, free: 1.602 MB / 462.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.002157/0.4013, allocations: 1.221 MB / 0.6262 GB, free: 348 kB / 462.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.776e-05/0.4014, allocations: 54 kB / 0.6262 GB, free: 296 kB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001199/0.4015, allocations: 76 kB / 0.6263 GB, free: 220 kB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.001478/0.403, allocations: 1.041 MB / 0.6273 GB, free: 15.12 MB / 478.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 2.311e-05/0.403, allocations: 4 kB / 0.6273 GB, free: 15.12 MB / 478.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.306e-05/0.4031, allocations: 32 kB / 0.6273 GB, free: 15.09 MB / 478.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.311e-05/0.4032, allocations: 20 kB / 0.6274 GB, free: 15.07 MB / 478.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001124/0.4043, allocations: 0.7727 MB / 0.6281 GB, free: 14.3 MB / 478.1 MB 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.005022/0.4093, allocations: 4.623 MB / 0.6326 GB, free: 9.316 MB / 478.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.0005314/0.4099, allocations: 388.8 kB / 0.633 GB, free: 8.93 MB / 478.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.0003316/0.4102, allocations: 266 kB / 0.6332 GB, free: 8.668 MB / 478.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0003558/0.4106, allocations: 433.8 kB / 0.6337 GB, free: 8.152 MB / 478.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.029e-05/0.4106, allocations: 38.89 kB / 0.6337 GB, free: 8.105 MB / 478.1 MB Notification: Performance of pre-optimization done (n=40): time 2.154e-06/0.4106, allocations: 0 / 0.6337 GB, free: 8.105 MB / 478.1 MB Notification: Performance of matching and sorting (n=40): time 0.001829/0.4125, allocations: 0.874 MB / 0.6346 GB, free: 7.203 MB / 478.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 3.335e-05/0.4125, allocations: 55.41 kB / 0.6346 GB, free: 7.137 MB / 478.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001133/0.4137, allocations: 0.9582 MB / 0.6355 GB, free: 6.172 MB / 478.1 MB Notification: Performance of collectPreVariables (initialization): time 6.052e-05/0.4137, allocations: 33.7 kB / 0.6356 GB, free: 6.133 MB / 478.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.000377/0.4141, allocations: 0.4989 MB / 0.6361 GB, free: 5.629 MB / 478.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0001349/0.4142, allocations: 145.9 kB / 0.6362 GB, free: 5.484 MB / 478.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001736/0.4144, allocations: 118.2 kB / 0.6363 GB, free: 5.363 MB / 478.1 MB Notification: Performance of setup shared object (initialization): time 0.0001191/0.4146, allocations: 337.9 kB / 0.6366 GB, free: 5.027 MB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0003276/0.4149, allocations: 226.9 kB / 0.6369 GB, free: 4.801 MB / 478.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0004703/0.4154, allocations: 443.1 kB / 0.6373 GB, free: 4.285 MB / 478.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.0007822/0.4162, allocations: 0.6629 MB / 0.6379 GB, free: 3.547 MB / 478.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.928e-06/0.4162, allocations: 4 kB / 0.6379 GB, free: 3.543 MB / 478.1 MB Notification: Performance of matching and sorting (n=70) (initialization): time 0.001412/0.4176, allocations: 0.8058 MB / 0.6387 GB, free: 2.727 MB / 478.1 MB Notification: Performance of prepare postOptimizeDAE: time 2.746e-05/0.4176, allocations: 8.094 kB / 0.6387 GB, free: 2.719 MB / 478.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.063e-05/0.4176, allocations: 12 kB / 0.6387 GB, free: 2.707 MB / 478.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0004323/0.4181, allocations: 92.78 kB / 0.6388 GB, free: 2.613 MB / 478.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003541/0.4184, allocations: 111.8 kB / 0.6389 GB, free: 2.504 MB / 478.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0004704/0.4189, allocations: 0.6225 MB / 0.6395 GB, free: 1.855 MB / 478.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005886/0.4195, allocations: 83.45 kB / 0.6396 GB, free: 1.773 MB / 478.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.524e-05/0.4196, allocations: 31.98 kB / 0.6396 GB, free: 1.742 MB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0007239/0.4203, allocations: 0.5672 MB / 0.6402 GB, free: 1.168 MB / 478.1 MB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0004558/0.4208, allocations: 438.2 kB / 0.6406 GB, free: 0.6523 MB / 478.1 MB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0007841/0.4216, allocations: 0.6686 MB / 0.6413 GB, free: 15.91 MB / 494.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 2.645e-06/0.4216, allocations: 0 / 0.6413 GB, free: 15.91 MB / 494.1 MB Notification: Performance of matching and sorting (n=70) (initialization_lambda0): time 0.001187/0.4228, allocations: 0.7815 MB / 0.642 GB, free: 15.11 MB / 494.1 MB Notification: Performance of prepare postOptimizeDAE: time 1.287e-05/0.4228, allocations: 8 kB / 0.642 GB, free: 15.11 MB / 494.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.763e-06/0.4228, allocations: 4 kB / 0.642 GB, free: 15.1 MB / 494.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0001735/0.423, allocations: 64.8 kB / 0.6421 GB, free: 15.04 MB / 494.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0003317/0.4234, allocations: 112.3 kB / 0.6422 GB, free: 14.93 MB / 494.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001606/0.425, allocations: 1.896 MB / 0.6441 GB, free: 12.88 MB / 494.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0005874/0.4256, allocations: 67.55 kB / 0.6441 GB, free: 12.81 MB / 494.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.75e-05/0.4256, allocations: 28 kB / 0.6442 GB, free: 12.79 MB / 494.1 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 25 * Number of states: 0 () * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (64): * Single equations (assignments): 63 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * 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): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,6)} Notification: Performance of prepare postOptimizeDAE: time 0.0002158/0.4259, allocations: 217 kB / 0.6444 GB, free: 12.57 MB / 494.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001564/0.426, allocations: 94.84 kB / 0.6445 GB, free: 12.47 MB / 494.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001053/0.4271, allocations: 0.6586 MB / 0.6451 GB, free: 11.81 MB / 494.1 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.044e-05/0.4271, allocations: 7.938 kB / 0.6451 GB, free: 11.8 MB / 494.1 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.723e-06/0.4271, allocations: 0 / 0.6451 GB, free: 11.8 MB / 494.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0008261/0.4279, allocations: 0.8087 MB / 0.6459 GB, free: 10.9 MB / 494.1 MB 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.002513/0.4305, allocations: 1.693 MB / 0.6475 GB, free: 9.121 MB / 494.1 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.107e-06/0.4305, allocations: 4 kB / 0.6476 GB, free: 9.117 MB / 494.1 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003234/0.4308, allocations: 80.02 kB / 0.6476 GB, free: 9.039 MB / 494.1 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.0001406/0.431, allocations: 40.84 kB / 0.6477 GB, free: 8.996 MB / 494.1 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.387e-05/0.431, allocations: 11.98 kB / 0.6477 GB, free: 8.984 MB / 494.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0003567/0.4314, allocations: 0.5679 MB / 0.6482 GB, free: 8.391 MB / 494.1 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.573e-06/0.4314, allocations: 0 / 0.6482 GB, free: 8.391 MB / 494.1 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001198/0.4326, allocations: 0.9538 MB / 0.6492 GB, free: 7.406 MB / 494.1 MB Notification: Performance of postOpt removeConstants (simulation): time 0.0004342/0.433, allocations: 247.9 kB / 0.6494 GB, free: 7.145 MB / 494.1 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.683e-05/0.4331, allocations: 8 kB / 0.6494 GB, free: 7.137 MB / 494.1 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0004837/0.4336, allocations: 39.89 kB / 0.6494 GB, free: 7.098 MB / 494.1 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 4.897e-05/0.4337, allocations: 23.97 kB / 0.6495 GB, free: 7.074 MB / 494.1 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.701e-05/0.4337, allocations: 19.98 kB / 0.6495 GB, free: 7.055 MB / 494.1 MB Notification: Performance of sorting global known variables: time 0.0008363/0.4346, allocations: 0.6785 MB / 0.6502 GB, free: 6.383 MB / 494.1 MB Notification: Performance of sort global known variables: time 1.41e-07/0.4346, allocations: 0 / 0.6502 GB, free: 6.383 MB / 494.1 MB Notification: Performance of remove unused functions: time 0.001452/0.4361, allocations: 0.5495 MB / 0.6507 GB, free: 5.832 MB / 494.1 MB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 5 * Number of states: 3 (vol[1].dynBal.U,vol[2].dynBal.U,vol[3].dynBal.U) * Number of discrete variables: 0 () * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for simulation (39): * Single equations (assignments): 36 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 2 * When equations: 0 * 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): 0 systems * Non-linear torn systems (#iteration vars, #inner vars): 1 system {(1,3)} Notification: Performance of Backend phase and start with SimCode phase: time 0.0006283/0.4367, allocations: 311 kB / 0.651 GB, free: 5.527 MB / 494.1 MB Notification: Performance of simCode: created initialization part: time 0.001569/0.4383, allocations: 0.9971 MB / 0.652 GB, free: 4.52 MB / 494.1 MB Notification: Performance of simCode: created event and clocks part: time 3.456e-06/0.4383, allocations: 0 / 0.652 GB, free: 4.52 MB / 494.1 MB Notification: Performance of simCode: created simulation system equations: time 0.000357/0.4387, allocations: 248.3 kB / 0.6522 GB, free: 4.277 MB / 494.1 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002162/0.4408, allocations: 0.5618 MB / 0.6527 GB, free: 3.746 MB / 494.1 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003052/0.4439, allocations: 2.011 MB / 0.6547 GB, free: 1.691 MB / 494.1 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0008011/0.4447, allocations: 1.228 MB / 0.6559 GB, free: 444 kB / 494.1 MB Notification: Performance of simCode: alias equations: time 0.0009865/0.4457, allocations: 443.9 kB / 0.6563 GB, free: 4 kB / 494.1 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001739/0.4459, allocations: 75.42 kB / 0.6564 GB, free: 15.93 MB / 0.4981 GB Notification: Performance of SimCode: time 9.72e-07/0.4459, allocations: 0 / 0.6564 GB, free: 15.93 MB / 0.4981 GB Notification: Performance of Templates: time 0.03328/0.4792, allocations: 20.4 MB / 0.6763 GB, free: 11.82 MB / 0.5137 GB make -j1 -f IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater.makefile (rm -f IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater.pipe ; mkfifo IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater.pipe ; head -c 1048576 < IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater.pipe >> ../files/IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater.sim & ./IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater -abortSlowSimulation -alarm=480 -s gbode -lv LOG_STATS > IDEAS_IDEAS.Fluid.MixingVolumes.BaseClasses.Validation.MixingVolumeHeatPortWater.pipe 2>&1)