Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesSpecializedWaterTemperatureDependentDensity.conf.json
Using package ModelicaServices with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package IBPSA with version 3.0.0 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo)
Using package Complex with version 3.2.3 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Running command: translateModel(IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesSpecializedWaterTemperatureDependentDensity,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesSpecializedWaterTemperatureDependentDensity")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002798/0.002798, allocations: 359.9 kB / 16.59 MB, free: 5.562 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 1.704/1.704, allocations: 165.8 MB / 183.1 MB, free: 5.398 MB / 138.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 4.266/4.266, allocations: 410.8 MB / 0.6001 GB, free: 15.26 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.002845/0.002845, allocations: 190.3 kB / 0.6668 GB, free: 6.918 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004873/0.0004874, allocations: 15.94 kB / 0.7429 GB, free: 8.953 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4105/0.411, allocations: 67.44 MB / 0.8087 GB, free: 28.77 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesSpecializedWaterTemperatureDependentDensity): time 0.02777/0.4389, allocations: 22.8 MB / 0.831 GB, free: 5.898 MB / 378.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01168/0.4506, allocations: 6.172 MB / 0.837 GB, free: 15.71 MB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001235/0.4519, allocations: 31.81 kB / 0.8371 GB, free: 15.68 MB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001598/0.4535, allocations: 369.7 kB / 0.8374 GB, free: 15.32 MB / 394.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.00558/0.4591, allocations: 1.413 MB / 0.8388 GB, free: 13.9 MB / 394.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.004342/0.4635, allocations: 0.9885 MB / 0.8398 GB, free: 12.93 MB / 394.7 MB
Notification: Performance of NFFlatten.flatten: time 0.004356/0.4678, allocations: 2.432 MB / 0.8421 GB, free: 10.49 MB / 394.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009947/0.4689, allocations: 455.4 kB / 0.8426 GB, free: 10.03 MB / 394.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001348/0.4702, allocations: 0.5677 MB / 0.8431 GB, free: 9.457 MB / 394.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.0009733/0.4712, allocations: 0.5055 MB / 0.8436 GB, free: 8.949 MB / 394.7 MB
Notification: Performance of NFPackage.collectConstants: time 9.362e-05/0.4713, allocations: 24 kB / 0.8436 GB, free: 8.926 MB / 394.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002283/0.4736, allocations: 0.6236 MB / 0.8442 GB, free: 8.301 MB / 394.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0002059/0.4738, allocations: 123.4 kB / 0.8444 GB, free: 8.18 MB / 394.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0002411/0.4741, allocations: 169.3 kB / 0.8445 GB, free: 8.008 MB / 394.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001632/0.4757, allocations: 0.9001 MB / 0.8454 GB, free: 7.105 MB / 394.7 MB
Notification: Performance of FrontEnd - DAE generated: time 4.768e-06/0.4758, allocations: 4 kB / 0.8454 GB, free: 7.102 MB / 394.7 MB
Notification: Performance of FrontEnd: time 2.515e-06/0.4758, allocations: 0 / 0.8454 GB, free: 7.102 MB / 394.7 MB
Notification: Performance of Transformations before backend: time 9.087e-06/0.4758, allocations: 0 / 0.8454 GB, free: 7.102 MB / 394.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 110
 * Number of variables: 110
Notification: Performance of Generate backend data structure: time 0.001939/0.4777, allocations: 0.9322 MB / 0.8463 GB, free: 6.121 MB / 394.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.919e-05/0.4778, allocations: 8.031 kB / 0.8463 GB, free: 6.113 MB / 394.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003667/0.4815, allocations: 286.7 kB / 0.8466 GB, free: 5.832 MB / 394.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.002167/0.4837, allocations: 0.6351 MB / 0.8472 GB, free: 5.156 MB / 394.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.037e-05/0.4837, allocations: 36.94 kB / 0.8473 GB, free: 5.121 MB / 394.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001183/0.4839, allocations: 44 kB / 0.8473 GB, free: 5.078 MB / 394.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001402/0.4853, allocations: 0.5243 MB / 0.8478 GB, free: 4.516 MB / 394.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.644e-05/0.4853, allocations: 0 / 0.8478 GB, free: 4.516 MB / 394.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.171e-05/0.4854, allocations: 16 kB / 0.8478 GB, free: 4.5 MB / 394.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 1.803e-05/0.4854, allocations: 12 kB / 0.8478 GB, free: 4.488 MB / 394.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.00117/0.4866, allocations: 363.6 kB / 0.8482 GB, free: 4.137 MB / 394.7 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.004484/0.4911, allocations: 2.822 MB / 0.8509 GB, free: 1.074 MB / 394.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0009792/0.4921, allocations: 302.1 kB / 0.8512 GB, free: 0.7617 MB / 394.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004564/0.4926, allocations: 146.1 kB / 0.8514 GB, free: 0.6133 MB / 394.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0007049/0.4933, allocations: 0.6612 MB / 0.852 GB, free: 15.8 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.71e-05/0.4934, allocations: 34.8 kB / 0.852 GB, free: 15.76 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=28): time 3.366e-06/0.4934, allocations: 0 / 0.852 GB, free: 15.76 MB / 410.7 MB
Notification: Performance of matching and sorting (n=40): time 0.01127/0.5047, allocations: 2.08 MB / 0.8541 GB, free: 13.6 MB / 410.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.114e-05/0.5048, allocations: 89 kB / 0.8542 GB, free: 13.5 MB / 410.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001163/0.5059, allocations: 0.5067 MB / 0.8547 GB, free: 12.98 MB / 410.7 MB
Notification: Performance of collectPreVariables (initialization): time 6.864e-05/0.506, allocations: 33.7 kB / 0.8547 GB, free: 12.94 MB / 410.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003422/0.5064, allocations: 324.3 kB / 0.855 GB, free: 12.62 MB / 410.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001969/0.5066, allocations: 141.9 kB / 0.8551 GB, free: 12.48 MB / 410.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.214e-05/0.5066, allocations: 8 kB / 0.8551 GB, free: 12.47 MB / 410.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001939/0.5068, allocations: 358.8 kB / 0.8555 GB, free: 12.11 MB / 410.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006352/0.5075, allocations: 169 kB / 0.8556 GB, free: 11.95 MB / 410.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007524/0.5083, allocations: 287.2 kB / 0.8559 GB, free: 11.62 MB / 410.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0007227/0.509, allocations: 211.5 kB / 0.8561 GB, free: 11.41 MB / 410.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.466e-06/0.509, allocations: 0 / 0.8561 GB, free: 11.41 MB / 410.7 MB
Notification: Performance of matching and sorting (n=55) (initialization): time 0.003198/0.5122, allocations: 0.7285 MB / 0.8568 GB, free: 10.67 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001496/0.5124, allocations: 176.5 kB / 0.857 GB, free: 10.45 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.182e-05/0.5124, allocations: 7.938 kB / 0.857 GB, free: 10.44 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001779/0.5142, allocations: 277.5 kB / 0.8573 GB, free: 10.16 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005526/0.5148, allocations: 67.91 kB / 0.8573 GB, free: 10.1 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01004/0.5248, allocations: 4.342 MB / 0.8616 GB, free: 5.496 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002002/0.5269, allocations: 87.81 kB / 0.8617 GB, free: 5.41 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.347e-05/0.527, allocations: 16 kB / 0.8617 GB, free: 5.395 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.023e-05/0.527, allocations: 4 kB / 0.8617 GB, free: 5.391 MB / 410.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.00314/0.5301, allocations: 0.6606 MB / 0.8623 GB, free: 4.723 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.697e-06/0.5302, allocations: 160 / 0.8623 GB, free: 4.723 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001788/0.532, allocations: 286 kB / 0.8626 GB, free: 4.438 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005517/0.5326, allocations: 63.91 kB / 0.8627 GB, free: 4.375 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01027/0.5428, allocations: 4.342 MB / 0.8669 GB, free: 15.77 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00202/0.5449, allocations: 87.75 kB / 0.867 GB, free: 15.68 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.908e-05/0.545, allocations: 19.95 kB / 0.867 GB, free: 15.66 MB / 426.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 14
 * 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 (39):
 * Single equations (assignments): 37
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {2 8,2 6}
Notification: Performance of prepare postOptimizeDAE: time 0.0004956/0.5455, allocations: 285 kB / 0.8673 GB, free: 15.38 MB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001965/0.5457, allocations: 59.25 kB / 0.8673 GB, free: 15.32 MB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003113/0.5488, allocations: 0.6566 MB / 0.868 GB, free: 14.65 MB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002787/0.5516, allocations: 0.7525 MB / 0.8687 GB, free: 13.84 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.308e-06/0.5517, allocations: 0 / 0.8687 GB, free: 13.84 MB / 426.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0004512/0.5521, allocations: 192.3 kB / 0.8689 GB, free: 13.63 MB / 426.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001344/0.5523, allocations: 8 kB / 0.8689 GB, free: 13.62 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001853/0.5541, allocations: 72.09 kB / 0.869 GB, free: 13.55 MB / 426.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001323/0.5543, allocations: 35.94 kB / 0.869 GB, free: 13.52 MB / 426.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.003836/0.5581, allocations: 0.8338 MB / 0.8698 GB, free: 12.67 MB / 426.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.002434/0.5606, allocations: 0.9251 MB / 0.8707 GB, free: 11.73 MB / 426.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0006724/0.5613, allocations: 203.9 kB / 0.8709 GB, free: 11.53 MB / 426.7 MB
Notification: Performance of sorting global known variables: time 0.0008557/0.5622, allocations: 354.8 kB / 0.8712 GB, free: 11.19 MB / 426.7 MB
Notification: Performance of Backend: time 7.72e-07/0.5622, allocations: 0 / 0.8712 GB, free: 11.19 MB / 426.7 MB
Notification: Performance of simCode: created initialization part: time 0.006562/0.5688, allocations: 1.585 MB / 0.8728 GB, free: 9.555 MB / 426.7 MB
Notification: Performance of SimCode: time 0.005074/0.5739, allocations: 2.204 MB / 0.8749 GB, free: 7.305 MB / 426.7 MB
Notification: Performance of Templates: time 0.04876/0.6227, allocations: 18.17 MB / 0.8927 GB, free: 5.316 MB / 442.7 MB