Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesSpecializedWaterConstantProperties_pT.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.CoupledVolumesSpecializedWaterConstantProperties_pT,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesSpecializedWaterConstantProperties_pT")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002592/0.002592, allocations: 355.5 kB / 16.59 MB, free: 5.566 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.497/1.497, allocations: 165.8 MB / 183.1 MB, free: 5.488 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.042/4.042, allocations: 410.8 MB / 0.6001 GB, free: 15.14 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.001757/0.001757, allocations: 200.9 kB / 0.6668 GB, free: 6.918 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000489/0.0004893, allocations: 15.98 kB / 0.7429 GB, free: 8.957 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4755/0.476, allocations: 67.44 MB / 0.8087 GB, free: 28.78 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.CoupledVolumesSpecializedWaterConstantProperties_pT): time 0.05055/0.5266, allocations: 34.21 MB / 0.8421 GB, free: 10.47 MB / 394.7 MB
Notification: Performance of NFInst.instExpressions: time 0.01954/0.5462, allocations: 6.45 MB / 0.8484 GB, free: 4.012 MB / 394.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001618/0.5479, allocations: 31.75 kB / 0.8485 GB, free: 3.98 MB / 394.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.002459/0.5504, allocations: 373.6 kB / 0.8488 GB, free: 3.613 MB / 394.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.007237/0.5577, allocations: 1.208 MB / 0.85 GB, free: 2.398 MB / 394.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.006654/0.5644, allocations: 1.069 MB / 0.8511 GB, free: 1.348 MB / 394.7 MB
Notification: Performance of NFFlatten.flatten: time 0.006611/0.571, allocations: 2.389 MB / 0.8534 GB, free: 14.95 MB / 410.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001757/0.5728, allocations: 453.2 kB / 0.8538 GB, free: 14.5 MB / 410.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.03594/0.6088, allocations: 9.292 MB / 0.8629 GB, free: 5.211 MB / 410.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001919/0.6108, allocations: 0.5016 MB / 0.8634 GB, free: 4.707 MB / 410.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0002283/0.611, allocations: 24 kB / 0.8634 GB, free: 4.684 MB / 410.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.02436/0.6354, allocations: 8.978 MB / 0.8722 GB, free: 11.7 MB / 426.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004327/0.6359, allocations: 123.4 kB / 0.8723 GB, free: 11.58 MB / 426.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0004196/0.6364, allocations: 161.4 kB / 0.8724 GB, free: 11.42 MB / 426.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.002062/0.6384, allocations: 0.8105 MB / 0.8732 GB, free: 10.61 MB / 426.7 MB
Notification: Performance of FrontEnd - DAE generated: time 5.32e-06/0.6385, allocations: 0 / 0.8732 GB, free: 10.61 MB / 426.7 MB
Notification: Performance of FrontEnd: time 1.884e-06/0.6385, allocations: 0 / 0.8732 GB, free: 10.61 MB / 426.7 MB
Notification: Performance of Transformations before backend: time 2.196e-05/0.6385, allocations: 0 / 0.8732 GB, free: 10.61 MB / 426.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.002143/0.6407, allocations: 0.907 MB / 0.8741 GB, free: 9.648 MB / 426.7 MB
Notification: Performance of prepare preOptimizeDAE: time 6.518e-05/0.6408, allocations: 8.031 kB / 0.8741 GB, free: 9.641 MB / 426.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.0004439/0.6412, allocations: 87.09 kB / 0.8742 GB, free: 9.555 MB / 426.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001928/0.6432, allocations: 0.6956 MB / 0.8749 GB, free: 8.82 MB / 426.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.832e-05/0.6433, allocations: 41 kB / 0.8749 GB, free: 8.777 MB / 426.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001157/0.6434, allocations: 52 kB / 0.875 GB, free: 8.727 MB / 426.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001314/0.6447, allocations: 0.4922 MB / 0.8755 GB, free: 8.203 MB / 426.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 3.38e-05/0.6448, allocations: 3.906 kB / 0.8755 GB, free: 8.199 MB / 426.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.314e-05/0.6449, allocations: 16 kB / 0.8755 GB, free: 8.184 MB / 426.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 4.142e-05/0.645, allocations: 16 kB / 0.8755 GB, free: 8.168 MB / 426.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.000881/0.6458, allocations: 319.7 kB / 0.8758 GB, free: 7.855 MB / 426.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.004544/0.6504, allocations: 2.729 MB / 0.8785 GB, free: 4.883 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0005077/0.651, allocations: 191.1 kB / 0.8787 GB, free: 4.688 MB / 426.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0002326/0.6512, allocations: 97.19 kB / 0.8787 GB, free: 4.59 MB / 426.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0004438/0.6517, allocations: 344.6 kB / 0.8791 GB, free: 4.18 MB / 426.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.711e-05/0.6517, allocations: 30.75 kB / 0.8791 GB, free: 4.141 MB / 426.7 MB
Notification: Performance of pre-optimization done (n=21): time 3.546e-06/0.6517, allocations: 3.938 kB / 0.8791 GB, free: 4.137 MB / 426.7 MB
Notification: Performance of matching and sorting (n=21): time 0.0009321/0.6527, allocations: 303.6 kB / 0.8794 GB, free: 3.836 MB / 426.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.288e-05/0.6528, allocations: 51.41 kB / 0.8794 GB, free: 3.773 MB / 426.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009727/0.6538, allocations: 0.5029 MB / 0.8799 GB, free: 3.262 MB / 426.7 MB
Notification: Performance of collectPreVariables (initialization): time 6.522e-05/0.6538, allocations: 33.7 kB / 0.88 GB, free: 3.223 MB / 426.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0003767/0.6542, allocations: 351.4 kB / 0.8803 GB, free: 2.875 MB / 426.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001275/0.6544, allocations: 71.02 kB / 0.8804 GB, free: 2.805 MB / 426.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 2.155e-05/0.6544, allocations: 4 kB / 0.8804 GB, free: 2.801 MB / 426.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001982/0.6546, allocations: 366.7 kB / 0.8807 GB, free: 2.434 MB / 426.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0002449/0.6549, allocations: 87.94 kB / 0.8808 GB, free: 2.348 MB / 426.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0003757/0.6553, allocations: 221.9 kB / 0.881 GB, free: 2.066 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0003393/0.6556, allocations: 131.4 kB / 0.8811 GB, free: 1.941 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.185e-06/0.6556, allocations: 4 kB / 0.8811 GB, free: 1.938 MB / 426.7 MB
Notification: Performance of matching and sorting (n=43) (initialization): time 0.0009839/0.6566, allocations: 377 kB / 0.8815 GB, free: 1.562 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0002072/0.6569, allocations: 220.4 kB / 0.8817 GB, free: 1.285 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.284e-05/0.6569, allocations: 7.938 kB / 0.8817 GB, free: 1.277 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.859e-05/0.6569, allocations: 8 kB / 0.8817 GB, free: 1.27 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005111/0.6574, allocations: 71.91 kB / 0.8818 GB, free: 1.199 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.919e-05/0.6575, allocations: 15.89 kB / 0.8818 GB, free: 1.184 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007369/0.6582, allocations: 63.5 kB / 0.8819 GB, free: 1.121 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.552e-05/0.6583, allocations: 16 kB / 0.8819 GB, free: 1.105 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.39e-05/0.6583, allocations: 4 kB / 0.8819 GB, free: 1.102 MB / 426.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0007811/0.6591, allocations: 303.6 kB / 0.8822 GB, free: 0.8047 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.476e-06/0.6591, allocations: 4 kB / 0.8822 GB, free: 0.8008 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 1.18e-05/0.6592, allocations: 8 kB / 0.8822 GB, free: 0.793 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0004654/0.6596, allocations: 75.91 kB / 0.8823 GB, free: 0.7188 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.025e-05/0.6597, allocations: 15.92 kB / 0.8823 GB, free: 0.7031 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.000648/0.6603, allocations: 36.33 kB / 0.8823 GB, free: 0.668 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.875e-05/0.6604, allocations: 20 kB / 0.8823 GB, free: 0.6484 MB / 426.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 19
 * 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 (43):
 * Single equations (assignments): 43
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0005388/0.6609, allocations: 280.9 kB / 0.8826 GB, free: 372 kB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001604/0.6611, allocations: 59.25 kB / 0.8827 GB, free: 312 kB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0007715/0.6619, allocations: 280 kB / 0.8829 GB, free: 28 kB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0005728/0.6625, allocations: 370.2 kB / 0.8833 GB, free: 15.62 MB / 442.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.24e-06/0.6625, allocations: 0 / 0.8833 GB, free: 15.62 MB / 442.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003987/0.6629, allocations: 172.3 kB / 0.8834 GB, free: 15.43 MB / 442.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001066/0.663, allocations: 8 kB / 0.8835 GB, free: 15.42 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.000666/0.6637, allocations: 27.97 kB / 0.8835 GB, free: 15.39 MB / 442.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 4.473e-05/0.6638, allocations: 11.98 kB / 0.8835 GB, free: 15.38 MB / 442.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0009217/0.6647, allocations: 328.1 kB / 0.8838 GB, free: 15.06 MB / 442.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001094/0.6658, allocations: 0.5253 MB / 0.8843 GB, free: 14.52 MB / 442.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.000222/0.6661, allocations: 103.6 kB / 0.8844 GB, free: 14.42 MB / 442.7 MB
Notification: Performance of sorting global known variables: time 0.0006913/0.6668, allocations: 354.8 kB / 0.8848 GB, free: 14.07 MB / 442.7 MB
Notification: Performance of Backend: time 8.12e-07/0.6668, allocations: 3.938 kB / 0.8848 GB, free: 14.07 MB / 442.7 MB
Notification: Performance of simCode: created initialization part: time 0.002372/0.6692, allocations: 0.5999 MB / 0.8853 GB, free: 13.48 MB / 442.7 MB
Notification: Performance of SimCode: time 0.005162/0.6744, allocations: 1.98 MB / 0.8873 GB, free: 11.45 MB / 442.7 MB
Notification: Performance of Templates: time 0.0352/0.7097, allocations: 11.8 MB / 0.8988 GB, free: 15.82 MB / 458.7 MB