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.001174/0.001174, allocations: 107.3 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.001169/0.001169, allocations: 192.1 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.28/1.28, allocations: 222.9 MB / 241.7 MB, free: 15.09 MB / 206.1 MB Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6701/0.6701, allocations: 115.1 MB / 406.9 MB, free: 6.312 MB / 318.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001226/0.001226, allocations: 59.91 kB / 494.8 MB, free: 15.84 MB / 414.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.3428/0.3441, allocations: 76.15 MB / 0.5576 GB, free: 36.71 MB / 446.1 MB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47): time 0.04034/0.3845, allocations: 40.3 MB / 0.5969 GB, free: 8.035 MB / 446.1 MB Notification: Performance of NFInst.instExpressions: time 0.006751/0.3913, allocations: 4.079 MB / 0.6009 GB, free: 4.996 MB / 446.1 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001327/0.3926, allocations: 34.22 kB / 0.6009 GB, free: 4.984 MB / 446.1 MB Notification: Performance of NFTyping.typeComponents: time 0.0009871/0.3936, allocations: 360.3 kB / 0.6013 GB, free: 4.676 MB / 446.1 MB Notification: Performance of NFTyping.typeBindings: time 0.005727/0.3994, allocations: 2.489 MB / 0.6037 GB, free: 2.934 MB / 446.1 MB Notification: Performance of NFTyping.typeClassSections: time 0.00206/0.4015, allocations: 0.9256 MB / 0.6046 GB, free: 2.234 MB / 446.1 MB Notification: Performance of NFFlatten.flatten: time 0.002362/0.4038, allocations: 2.194 MB / 0.6067 GB, free: 0.9414 MB / 446.1 MB Notification: Performance of NFFlatten.resolveConnections: time 0.0006775/0.4045, allocations: 0.6502 MB / 0.6074 GB, free: 0.5156 MB / 446.1 MB Notification: Performance of NFEvalConstants.evaluate: time 0.004061/0.4086, allocations: 2.368 MB / 0.6097 GB, free: 15.08 MB / 462.1 MB Notification: Performance of NFSimplifyModel.simplify: time 0.0009217/0.4095, allocations: 0.5522 MB / 0.6102 GB, free: 14.52 MB / 462.1 MB Notification: Performance of NFPackage.collectConstants: time 9.728e-05/0.4096, allocations: 64 kB / 0.6103 GB, free: 14.46 MB / 462.1 MB Notification: Performance of NFFlatten.collectFunctions: time 0.005452/0.4151, allocations: 3.197 MB / 0.6134 GB, free: 11.26 MB / 462.1 MB Notification: Performance of NFScalarize.scalarize: time 0.0002007/0.4153, allocations: 183.4 kB / 0.6136 GB, free: 11.08 MB / 462.1 MB Notification: Performance of NFVerifyModel.verify: time 0.0004639/0.4158, allocations: 394.1 kB / 0.614 GB, free: 10.69 MB / 462.1 MB Notification: Performance of NFConvertDAE.convert: time 0.002994/0.4188, allocations: 1.831 MB / 0.6158 GB, free: 8.855 MB / 462.1 MB Notification: Performance of FrontEnd - DAE generated: time 4.759e-06/0.4188, allocations: 0 / 0.6158 GB, free: 8.855 MB / 462.1 MB Notification: Performance of FrontEnd: time 1.363e-06/0.4188, allocations: 0 / 0.6158 GB, free: 8.855 MB / 462.1 MB Notification: Performance of Transformations before backend: time 1.312e-05/0.4188, allocations: 4 kB / 0.6158 GB, free: 8.852 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.001547/0.4204, allocations: 1.188 MB / 0.6169 GB, free: 7.609 MB / 462.1 MB Notification: Performance of prepare preOptimizeDAE: time 3.415e-05/0.4204, allocations: 8.031 kB / 0.6169 GB, free: 7.602 MB / 462.1 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001119/0.4215, allocations: 155.8 kB / 0.6171 GB, free: 7.449 MB / 462.1 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001274/0.4228, allocations: 0.7952 MB / 0.6179 GB, free: 6.613 MB / 462.1 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 2.665e-05/0.4229, allocations: 33 kB / 0.6179 GB, free: 6.582 MB / 462.1 MB Notification: Performance of preOpt expandDerOperator (simulation): time 6.527e-05/0.4229, allocations: 48 kB / 0.6179 GB, free: 6.535 MB / 462.1 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.0007366/0.4237, allocations: 0.5196 MB / 0.6184 GB, free: 5.98 MB / 462.1 MB Notification: Performance of preOpt findStateOrder (simulation): time 1.67e-05/0.4237, allocations: 0 / 0.6184 GB, free: 5.98 MB / 462.1 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 4.95e-05/0.4238, allocations: 16 kB / 0.6185 GB, free: 5.965 MB / 462.1 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.273e-05/0.4238, allocations: 12 kB / 0.6185 GB, free: 5.953 MB / 462.1 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0005192/0.4243, allocations: 343.7 kB / 0.6188 GB, free: 5.617 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.002491/0.4268, allocations: 2.447 MB / 0.6212 GB, free: 2.996 MB / 462.1 MB Notification: Performance of preOpt comSubExp (simulation): time 0.0003932/0.4272, allocations: 271.2 kB / 0.6214 GB, free: 2.723 MB / 462.1 MB Notification: Performance of preOpt resolveLoops (simulation): time 0.0001802/0.4274, allocations: 136.8 kB / 0.6216 GB, free: 2.586 MB / 462.1 MB Notification: Performance of preOpt evalFunc (simulation): time 0.0008437/0.4283, allocations: 1.378 MB / 0.6229 GB, free: 0.8945 MB / 462.1 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.338e-05/0.4283, allocations: 38.55 kB / 0.623 GB, free: 0.8477 MB / 462.1 MB Notification: Performance of pre-optimization done (n=31): time 1.443e-06/0.4283, allocations: 0 / 0.623 GB, free: 0.8477 MB / 462.1 MB Notification: Performance of matching and sorting (n=43): time 0.003919/0.4322, allocations: 1.79 MB / 0.6247 GB, free: 14.96 MB / 478.1 MB Notification: Performance of inlineWhenForInitialization (initialization): time 4.469e-05/0.4323, allocations: 59.41 kB / 0.6248 GB, free: 14.89 MB / 478.1 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0005342/0.4328, allocations: 0.4952 MB / 0.6252 GB, free: 14.38 MB / 478.1 MB Notification: Performance of collectPreVariables (initialization): time 3.508e-05/0.4329, allocations: 41.7 kB / 0.6253 GB, free: 14.34 MB / 478.1 MB Notification: Performance of collectInitialEqns (initialization): time 0.0002147/0.4331, allocations: 328.4 kB / 0.6256 GB, free: 14.01 MB / 478.1 MB Notification: Performance of collectInitialBindings (initialization): time 0.0001179/0.4332, allocations: 153.7 kB / 0.6257 GB, free: 13.86 MB / 478.1 MB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001203/0.4333, allocations: 90.16 kB / 0.6258 GB, free: 13.77 MB / 478.1 MB Notification: Performance of setup shared object (initialization): time 0.0001342/0.4335, allocations: 366.8 kB / 0.6262 GB, free: 13.4 MB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002311/0.4337, allocations: 159 kB / 0.6263 GB, free: 13.24 MB / 478.1 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0002957/0.434, allocations: 266.8 kB / 0.6266 GB, free: 12.94 MB / 478.1 MB Notification: Performance of analyzeInitialSystem (initialization): time 0.0005593/0.4346, allocations: 444.9 kB / 0.627 GB, free: 12.46 MB / 478.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.803e-06/0.4346, allocations: 0 / 0.627 GB, free: 12.46 MB / 478.1 MB Notification: Performance of matching and sorting (n=57) (initialization): time 0.0009204/0.4355, allocations: 0.6035 MB / 0.6276 GB, free: 11.85 MB / 478.1 MB Notification: Performance of prepare postOptimizeDAE: time 1.886e-05/0.4356, allocations: 8 kB / 0.6276 GB, free: 11.84 MB / 478.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.805e-06/0.4356, allocations: 4 kB / 0.6276 GB, free: 11.84 MB / 478.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0007/0.4363, allocations: 205.5 kB / 0.6278 GB, free: 11.63 MB / 478.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000228/0.4365, allocations: 63.91 kB / 0.6279 GB, free: 11.57 MB / 478.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.000977/0.4375, allocations: 1.347 MB / 0.6292 GB, free: 10.17 MB / 478.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003373/0.4378, allocations: 23.92 kB / 0.6292 GB, free: 10.14 MB / 478.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.144e-05/0.4379, allocations: 20 kB / 0.6292 GB, free: 10.12 MB / 478.1 MB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.000378/0.4383, allocations: 313.2 kB / 0.6295 GB, free: 9.816 MB / 478.1 MB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0002913/0.4386, allocations: 266.5 kB / 0.6298 GB, free: 9.508 MB / 478.1 MB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0005285/0.4391, allocations: 442.8 kB / 0.6302 GB, free: 9.035 MB / 478.1 MB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.613e-06/0.4391, allocations: 0 / 0.6302 GB, free: 9.035 MB / 478.1 MB Notification: Performance of matching and sorting (n=57) (initialization_lambda0): time 0.0009044/0.44, allocations: 0.607 MB / 0.6308 GB, free: 8.414 MB / 478.1 MB Notification: Performance of prepare postOptimizeDAE: time 8.936e-06/0.4401, allocations: 4 kB / 0.6308 GB, free: 8.41 MB / 478.1 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.418e-06/0.4401, allocations: 4 kB / 0.6308 GB, free: 8.406 MB / 478.1 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0006238/0.4407, allocations: 201.5 kB / 0.631 GB, free: 8.203 MB / 478.1 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0002042/0.4409, allocations: 68.09 kB / 0.6311 GB, free: 8.137 MB / 478.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0009328/0.4418, allocations: 1.351 MB / 0.6324 GB, free: 6.734 MB / 478.1 MB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0003176/0.4422, allocations: 15.98 kB / 0.6324 GB, free: 6.719 MB / 478.1 MB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 3.631e-05/0.4422, allocations: 24 kB / 0.6324 GB, free: 6.695 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.0001461/0.4424, allocations: 214.8 kB / 0.6326 GB, free: 6.48 MB / 478.1 MB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001198/0.4425, allocations: 63.23 kB / 0.6327 GB, free: 6.418 MB / 478.1 MB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001107/0.4436, allocations: 0.6245 MB / 0.6333 GB, free: 5.789 MB / 478.1 MB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.024e-05/0.4436, allocations: 11.92 kB / 0.6333 GB, free: 5.777 MB / 478.1 MB Notification: Performance of postOpt constantLinearSystem (simulation): time 4.599e-06/0.4436, allocations: 4 kB / 0.6333 GB, free: 5.773 MB / 478.1 MB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0008325/0.4445, allocations: 0.6519 MB / 0.6339 GB, free: 5.066 MB / 478.1 MB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.002061/0.4466, allocations: 1.462 MB / 0.6354 GB, free: 3.539 MB / 478.1 MB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.466e-06/0.4466, allocations: 0 / 0.6354 GB, free: 3.539 MB / 478.1 MB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0001602/0.4467, allocations: 47.91 kB / 0.6354 GB, free: 3.492 MB / 478.1 MB Notification: Performance of postOpt tearingSystem (simulation): time 0.0008732/0.4476, allocations: 213.6 kB / 0.6356 GB, free: 3.277 MB / 478.1 MB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 2.836e-05/0.4477, allocations: 11.94 kB / 0.6356 GB, free: 3.266 MB / 478.1 MB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.0009601/0.4486, allocations: 1.327 MB / 0.6369 GB, free: 1.887 MB / 478.1 MB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.323e-06/0.4486, allocations: 208 / 0.6369 GB, free: 1.887 MB / 478.1 MB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001274/0.4499, allocations: 0.8822 MB / 0.6378 GB, free: 0.9766 MB / 478.1 MB Notification: Performance of postOpt removeConstants (simulation): time 0.000238/0.4502, allocations: 188.3 kB / 0.638 GB, free: 0.7734 MB / 478.1 MB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 6.736e-05/0.4502, allocations: 12.06 kB / 0.638 GB, free: 0.7617 MB / 478.1 MB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0003387/0.4506, allocations: 19.92 kB / 0.638 GB, free: 0.7422 MB / 478.1 MB Notification: Performance of postOpt findZeroCrossings (simulation): time 4.284e-05/0.4506, allocations: 23.92 kB / 0.638 GB, free: 0.7188 MB / 478.1 MB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.035e-05/0.4507, allocations: 23.98 kB / 0.638 GB, free: 0.6953 MB / 478.1 MB Notification: Performance of sorting global known variables: time 0.0003645/0.451, allocations: 354.8 kB / 0.6384 GB, free: 360 kB / 478.1 MB Notification: Performance of sort global known variables: time 1.312e-06/0.4511, allocations: 0 / 0.6384 GB, free: 360 kB / 478.1 MB Notification: Performance of remove unused functions: time 0.001183/0.4522, allocations: 467.8 kB / 0.6388 GB, free: 15.89 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.0008401/0.4531, allocations: 464.2 kB / 0.6393 GB, free: 15.44 MB / 494.1 MB Notification: Performance of simCode: created initialization part: time 0.001153/0.4543, allocations: 0.6728 MB / 0.6399 GB, free: 14.77 MB / 494.1 MB Notification: Performance of simCode: created event and clocks part: time 3.166e-06/0.4543, allocations: 4 kB / 0.6399 GB, free: 14.77 MB / 494.1 MB Notification: Performance of simCode: created simulation system equations: time 0.0004441/0.4547, allocations: 248.4 kB / 0.6402 GB, free: 14.52 MB / 494.1 MB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.001235/0.456, allocations: 323 kB / 0.6405 GB, free: 14.22 MB / 494.1 MB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.001705/0.4577, allocations: 1.197 MB / 0.6416 GB, free: 13 MB / 494.1 MB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0004356/0.4581, allocations: 0.9144 MB / 0.6425 GB, free: 12.06 MB / 494.1 MB Notification: Performance of simCode: alias equations: time 0.000454/0.4586, allocations: 199.9 kB / 0.6427 GB, free: 11.87 MB / 494.1 MB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.000137/0.4587, allocations: 63.41 kB / 0.6428 GB, free: 11.8 MB / 494.1 MB Notification: Performance of SimCode: time 3.4e-07/0.4587, allocations: 0 / 0.6428 GB, free: 11.8 MB / 494.1 MB Notification: Performance of Templates: time 0.02441/0.4832, allocations: 16.97 MB / 0.6594 GB, free: 11.04 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 cvode -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesGlycol47.pipe 2>&1)