Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.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.MixingVolumes.Validation.CoupledVolumesGlycol47,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47") translateModel(IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001087/0.001087, allocations: 112.2 kB / 17.03 MB, free: 5.656 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.001068/0.001068, allocations: 192.6 kB / 17.97 MB, free: 5.062 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.336/1.336, allocations: 222.9 MB / 241.7 MB, free: 15.14 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.724/0.724, allocations: 115.1 MB / 406.9 MB, free: 6.371 MB / 318.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001416/0.001416, allocations: 63.91 kB / 494.8 MB, free: 15.86 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3218/0.3232, allocations: 76.13 MB / 0.5576 GB, free: 36.75 MB / 446.1 MB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47): time 0.03641/0.3597, allocations: 40.29 MB / 0.5969 GB, free: 8.07 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.007043/0.3667, allocations: 4.084 MB / 0.6009 GB, free: 5.047 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001369/0.3681, allocations: 34.47 kB / 0.6009 GB, free: 5.035 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0009759/0.3692, allocations: 359.8 kB / 0.6013 GB, free: 4.727 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.006066/0.3752, allocations: 2.489 MB / 0.6037 GB, free: 2.984 MB / 446.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.002385/0.3776, allocations: 0.9242 MB / 0.6046 GB, free: 2.285 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.002934/0.3806, allocations: 2.198 MB / 0.6067 GB, free: 0.9922 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0009204/0.3815, allocations: 0.6389 MB / 0.6074 GB, free: 0.5781 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.004458/0.386, allocations: 2.377 MB / 0.6097 GB, free: 15.1 MB / 462.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.001125/0.3872, allocations: 0.5522 MB / 0.6102 GB, free: 14.54 MB / 462.1 MB Notification: Performance of NFPackage.collectConstants: time 0.0001304/0.3873, allocations: 63.94 kB / 0.6103 GB, free: 14.48 MB / 462.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.005657/0.393, allocations: 3.195 MB / 0.6134 GB, free: 11.28 MB / 462.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0002706/0.3933, allocations: 175.4 kB / 0.6136 GB, free: 11.11 MB / 462.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0005456/0.3938, allocations: 406.1 kB / 0.614 GB, free: 10.71 MB / 462.1 MB Notification: Performance of NFConvertDAE.convert: time 0.00366/0.3975, allocations: 1.831 MB / 0.6158 GB, free: 8.875 MB / 462.1 MB Notification: Performance of FrontEnd - DAE generated: time 5.32e-06/0.3975, allocations: 0 / 0.6158 GB, free: 8.875 MB / 462.1 MB Notification: Performance of FrontEnd: time 2.314e-06/0.3976, allocations: 0 / 0.6158 GB, free: 8.875 MB / 462.1 MB Notification: Performance of Transformations before backend: time 1.925e-05/0.3976, allocations: 0 / 0.6158 GB, free: 8.875 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: 112 * Number of variables: 112 Notification: Performance of Generate backend data structure: time 0.001805/0.3994, allocations: 1.188 MB / 0.6169 GB, free: 7.633 MB / 462.1 MB Notification: Performance of prepare preOptimizeDAE: time 3.857e-05/0.3994, allocations: 11.97 kB / 0.6169 GB, free: 7.621 MB / 462.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001272/0.4007, allocations: 159.9 kB / 0.6171 GB, free: 7.465 MB / 462.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001555/0.4023, allocations: 0.7796 MB / 0.6178 GB, free: 6.645 MB / 462.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 3.427e-05/0.4023, allocations: 37 kB / 0.6179 GB, free: 6.609 MB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 7.746e-05/0.4024, allocations: 51.97 kB / 0.6179 GB, free: 6.559 MB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0007937/0.4032, allocations: 0.5196 MB / 0.6184 GB, free: 6.004 MB / 462.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 1.942e-05/0.4033, allocations: 3.938 kB / 0.6184 GB, free: 6 MB / 462.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.721e-05/0.4033, allocations: 20 kB / 0.6185 GB, free: 5.98 MB / 462.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.145e-05/0.4033, allocations: 12 kB / 0.6185 GB, free: 5.969 MB / 462.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0005345/0.4039, allocations: 343.7 kB / 0.6188 GB, free: 5.633 MB / 462.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.002703/0.4066, allocations: 2.443 MB / 0.6212 GB, free: 3.016 MB / 462.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.0004178/0.407, allocations: 272.8 kB / 0.6214 GB, free: 2.742 MB / 462.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.0001916/0.4072, allocations: 140.8 kB / 0.6216 GB, free: 2.602 MB / 462.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.000878/0.4081, allocations: 1.378 MB / 0.6229 GB, free: 0.9102 MB / 462.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.309e-05/0.4081, allocations: 42.5 kB / 0.623 GB, free: 0.8594 MB / 462.1 MB Notification: Performance of pre-optimization done (n=31): time 2.475e-06/0.4082, allocations: 0 / 0.623 GB, free: 0.8594 MB / 462.1 MB Notification: Performance of matching and sorting (n=43): time 0.00438/0.4125, allocations: 1.79 MB / 0.6247 GB, free: 14.97 MB / 478.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 4.341e-05/0.4126, allocations: 55.41 kB / 0.6248 GB, free: 14.91 MB / 478.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005828/0.4132, allocations: 0.4952 MB / 0.6252 GB, free: 14.4 MB / 478.1 MB Notification: Performance of collectPreVariables (initialization): time 4.008e-05/0.4132, allocations: 33.7 kB / 0.6253 GB, free: 14.36 MB / 478.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0002142/0.4135, allocations: 324.4 kB / 0.6256 GB, free: 14.04 MB / 478.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0001221/0.4136, allocations: 157.7 kB / 0.6257 GB, free: 13.88 MB / 478.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001331/0.4137, allocations: 94.16 kB / 0.6258 GB, free: 13.79 MB / 478.1 MB Notification: Performance of setup shared object (initialization): time 0.0001321/0.4139, allocations: 362.8 kB / 0.6262 GB, free: 13.42 MB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002499/0.4141, allocations: 159 kB / 0.6263 GB, free: 13.27 MB / 478.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003259/0.4145, allocations: 264.8 kB / 0.6266 GB, free: 12.96 MB / 478.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.0005807/0.4151, allocations: 444.9 kB / 0.627 GB, free: 12.49 MB / 478.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 2.635e-06/0.4151, allocations: 0 / 0.627 GB, free: 12.49 MB / 478.1 MB Notification: Performance of matching and sorting (n=57) (initialization): time 0.00102/0.4161, allocations: 0.6032 MB / 0.6276 GB, free: 11.88 MB / 478.1 MB Notification: Performance of prepare postOptimizeDAE: time 1.747e-05/0.4161, allocations: 7.984 kB / 0.6276 GB, free: 11.87 MB / 478.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.977e-06/0.4161, allocations: 4 kB / 0.6276 GB, free: 11.86 MB / 478.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0007508/0.4169, allocations: 197.9 kB / 0.6278 GB, free: 11.66 MB / 478.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002435/0.4172, allocations: 63.91 kB / 0.6279 GB, free: 11.6 MB / 478.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.001059/0.4182, allocations: 1.351 MB / 0.6292 GB, free: 10.2 MB / 478.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004094/0.4187, allocations: 28.05 kB / 0.6292 GB, free: 10.17 MB / 478.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.16e-05/0.4187, allocations: 28 kB / 0.6292 GB, free: 10.14 MB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0004186/0.4191, allocations: 309.2 kB / 0.6295 GB, free: 9.84 MB / 478.1 MB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0003084/0.4195, allocations: 266.4 kB / 0.6298 GB, free: 9.531 MB / 478.1 MB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0005563/0.42, allocations: 434.8 kB / 0.6302 GB, free: 9.066 MB / 478.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.797e-06/0.42, allocations: 4.094 kB / 0.6302 GB, free: 9.062 MB / 478.1 MB Notification: Performance of matching and sorting (n=57) (initialization_lambda0): time 0.0009869/0.421, allocations: 0.6106 MB / 0.6308 GB, free: 8.438 MB / 478.1 MB Notification: Performance of prepare postOptimizeDAE: time 1.267e-05/0.4211, allocations: 8 kB / 0.6308 GB, free: 8.43 MB / 478.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.701e-06/0.4211, allocations: 4 kB / 0.6308 GB, free: 8.426 MB / 478.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0007286/0.4218, allocations: 201.9 kB / 0.631 GB, free: 8.223 MB / 478.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002481/0.4221, allocations: 71.84 kB / 0.6311 GB, free: 8.152 MB / 478.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0009965/0.4231, allocations: 1.347 MB / 0.6324 GB, free: 6.754 MB / 478.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0004211/0.4235, allocations: 19.98 kB / 0.6324 GB, free: 6.734 MB / 478.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.453e-05/0.4236, allocations: 20 kB / 0.6324 GB, free: 6.715 MB / 478.1 MB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 13 * 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 (41): * Single equations (assignments): 39 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * 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): 2 systems {(2,8), (1,7)} Notification: Performance of prepare postOptimizeDAE: time 0.0001906/0.4237, allocations: 208.4 kB / 0.6326 GB, free: 6.504 MB / 478.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001533/0.4239, allocations: 63.34 kB / 0.6327 GB, free: 6.441 MB / 478.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001256/0.4252, allocations: 0.6295 MB / 0.6333 GB, free: 5.809 MB / 478.1 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.144e-05/0.4252, allocations: 7.938 kB / 0.6333 GB, free: 5.801 MB / 478.1 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 5.48e-06/0.4252, allocations: 0 / 0.6333 GB, free: 5.801 MB / 478.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0008876/0.4261, allocations: 0.6559 MB / 0.6339 GB, free: 5.09 MB / 478.1 MB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.00234/0.4285, allocations: 1.454 MB / 0.6354 GB, free: 3.57 MB / 478.1 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.72e-06/0.4285, allocations: 0 / 0.6354 GB, free: 3.57 MB / 478.1 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.000183/0.4287, allocations: 51.91 kB / 0.6354 GB, free: 3.52 MB / 478.1 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.0009827/0.4297, allocations: 221.6 kB / 0.6356 GB, free: 3.297 MB / 478.1 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 3.727e-05/0.4297, allocations: 15.94 kB / 0.6356 GB, free: 3.281 MB / 478.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001016/0.4307, allocations: 1.323 MB / 0.6369 GB, free: 1.906 MB / 478.1 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.853e-06/0.4307, allocations: 0 / 0.6369 GB, free: 1.906 MB / 478.1 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001424/0.4322, allocations: 0.8745 MB / 0.6378 GB, free: 1.004 MB / 478.1 MB Notification: Performance of postOpt removeConstants (simulation): time 0.0003109/0.4325, allocations: 188.3 kB / 0.638 GB, free: 0.8008 MB / 478.1 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 9.78e-05/0.4326, allocations: 12 kB / 0.638 GB, free: 0.7891 MB / 478.1 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003997/0.433, allocations: 15.92 kB / 0.638 GB, free: 0.7734 MB / 478.1 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 5.256e-05/0.4331, allocations: 31.92 kB / 0.638 GB, free: 0.7422 MB / 478.1 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.57e-05/0.4331, allocations: 19.98 kB / 0.638 GB, free: 0.7227 MB / 478.1 MB Notification: Performance of sorting global known variables: time 0.0004333/0.4336, allocations: 358.8 kB / 0.6384 GB, free: 384 kB / 478.1 MB Notification: Performance of sort global known variables: time 1.81e-07/0.4336, allocations: 4 kB / 0.6384 GB, free: 380 kB / 478.1 MB Notification: Performance of remove unused functions: time 0.001422/0.435, allocations: 459.8 kB / 0.6388 GB, free: 15.92 MB / 494.1 MB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 2 * Number of states: 2 (vol.dynBal.medium.T,vol1.dynBal.medium.T) * 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 (30): * Single equations (assignments): 27 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 1 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 2 * 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): 2 systems {(2,7), (2,5)} Notification: Performance of Backend phase and start with SimCode phase: time 0.001098/0.4361, allocations: 454.8 kB / 0.6393 GB, free: 15.48 MB / 494.1 MB Notification: Performance of simCode: created initialization part: time 0.00137/0.4375, allocations: 0.6799 MB / 0.6399 GB, free: 14.8 MB / 494.1 MB Notification: Performance of simCode: created event and clocks part: time 3.918e-06/0.4375, allocations: 0 / 0.6399 GB, free: 14.8 MB / 494.1 MB Notification: Performance of simCode: created simulation system equations: time 0.0005321/0.4381, allocations: 253.2 kB / 0.6402 GB, free: 14.55 MB / 494.1 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001461/0.4395, allocations: 330.2 kB / 0.6405 GB, free: 14.25 MB / 494.1 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002014/0.4416, allocations: 1.196 MB / 0.6416 GB, free: 13.02 MB / 494.1 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004856/0.4421, allocations: 0.9105 MB / 0.6425 GB, free: 12.09 MB / 494.1 MB Notification: Performance of simCode: alias equations: time 0.0005769/0.4427, allocations: 204.9 kB / 0.6427 GB, free: 11.89 MB / 494.1 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0001493/0.4428, allocations: 59.41 kB / 0.6428 GB, free: 11.83 MB / 494.1 MB Notification: Performance of SimCode: time 2.124e-06/0.4428, allocations: 0 / 0.6428 GB, free: 11.83 MB / 494.1 MB Notification: Performance of Templates: time 0.02768/0.4705, allocations: 16.97 MB / 0.6594 GB, free: 11.05 MB / 0.4981 GB make -j1 -f IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.makefile (rm -f IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.sim & ./IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47 -abortSlowSimulation -alarm=480 -s gbode -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe 2>&1)