Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass.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.MixingVolumeSteadyStateMass,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.002536/0.002536, allocations: 355.5 kB / 16.59 MB, free: 5.57 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.483/1.483, allocations: 165.8 MB / 183.1 MB, free: 5.465 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.158/4.158, 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.00169/0.001689, allocations: 191.2 kB / 0.6668 GB, free: 6.902 MB / 298.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000594/0.0005941, allocations: 15.98 kB / 0.7429 GB, free: 8.941 MB / 378.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4098/0.4104, allocations: 67.44 MB / 0.8087 GB, free: 28.75 MB / 378.7 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeSteadyStateMass): time 0.6618/1.072, allocations: 159.5 MB / 0.9645 GB, free: 1.32 MB / 474.7 MB
Notification: Performance of NFInst.instExpressions: time 0.009263/1.082, allocations: 4.429 MB / 0.9688 GB, free: 1.242 MB / 474.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.001158/1.083, allocations: 23.25 kB / 0.9689 GB, free: 1.242 MB / 474.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.001615/1.084, allocations: 340 kB / 0.9692 GB, free: 1.242 MB / 474.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.005279/1.09, allocations: 1.26 MB / 0.9704 GB, free: 1.133 MB / 474.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003662/1.093, allocations: 0.7874 MB / 0.9712 GB, free: 1.078 MB / 474.7 MB
Notification: Performance of NFFlatten.flatten: time 0.003323/1.097, allocations: 1.874 MB / 0.973 GB, free: 0.8164 MB / 474.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.0009512/1.098, allocations: 390.7 kB / 0.9734 GB, free: 0.75 MB / 474.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.001597/1.099, allocations: 0.5062 MB / 0.9739 GB, free: 0.6328 MB / 474.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.001206/1.101, allocations: 469.5 kB / 0.9743 GB, free: 0.543 MB / 474.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.0001299/1.101, allocations: 23.78 kB / 0.9743 GB, free: 0.5391 MB / 474.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002239/1.103, allocations: 0.5495 MB / 0.9749 GB, free: 496 kB / 474.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.0004445/1.104, allocations: 200.6 kB / 0.9751 GB, free: 476 kB / 474.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.0003292/1.104, allocations: 148.8 kB / 0.9752 GB, free: 424 kB / 474.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.001701/1.106, allocations: 0.7804 MB / 0.976 GB, free: 356 kB / 474.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.035e-06/1.106, allocations: 2.969 kB / 0.976 GB, free: 356 kB / 474.7 MB
Notification: Performance of FrontEnd: time 2.474e-06/1.106, allocations: 0 / 0.976 GB, free: 356 kB / 474.7 MB
Notification: Performance of Transformations before backend: time 1.265e-05/1.106, allocations: 0 / 0.976 GB, free: 356 kB / 474.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 104
 * Number of variables: 104
Notification: Performance of Generate backend data structure: time 0.002215/1.108, allocations: 0.8581 MB / 0.9768 GB, free: 15.76 MB / 490.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.92e-05/1.108, allocations: 9.688 kB / 0.9768 GB, free: 15.76 MB / 490.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001636/1.11, allocations: 172 kB / 0.977 GB, free: 15.72 MB / 490.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001378/1.111, allocations: 0.5134 MB / 0.9775 GB, free: 15.44 MB / 490.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 4.389e-05/1.111, allocations: 38.16 kB / 0.9775 GB, free: 15.43 MB / 490.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001066/1.111, allocations: 42.94 kB / 0.9776 GB, free: 15.43 MB / 490.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001329/1.113, allocations: 462.3 kB / 0.978 GB, free: 15.3 MB / 490.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 2.606e-05/1.113, allocations: 6.906 kB / 0.978 GB, free: 15.3 MB / 490.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 6.463e-05/1.113, allocations: 16.69 kB / 0.978 GB, free: 15.3 MB / 490.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 3.939e-05/1.113, allocations: 19.64 kB / 0.9781 GB, free: 15.29 MB / 490.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001246/1.114, allocations: 420.6 kB / 0.9785 GB, free: 15.23 MB / 490.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.004303/1.118, allocations: 2.026 MB / 0.9804 GB, free: 13.86 MB / 490.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0007364/1.119, allocations: 281.1 kB / 0.9807 GB, free: 13.8 MB / 490.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004979/1.12, allocations: 190.4 kB / 0.9809 GB, free: 13.77 MB / 490.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003904/1.12, allocations: 192.1 kB / 0.9811 GB, free: 13.57 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.476e-05/1.12, allocations: 38.12 kB / 0.9811 GB, free: 13.53 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=30): time 4.157e-06/1.12, allocations: 1.844 kB / 0.9811 GB, free: 13.53 MB / 490.7 MB
Notification: Performance of matching and sorting (n=30): time 0.002565/1.123, allocations: 0.6597 MB / 0.9818 GB, free: 13.27 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.666e-05/1.123, allocations: 54.34 kB / 0.9818 GB, free: 13.21 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0007246/1.124, allocations: 435.2 kB / 0.9822 GB, free: 13.04 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 9.505e-05/1.124, allocations: 37.81 kB / 0.9823 GB, free: 13 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.0002743/1.124, allocations: 270.1 kB / 0.9825 GB, free: 12.84 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0001756/1.124, allocations: 112 kB / 0.9826 GB, free: 12.76 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 2.492e-05/1.124, allocations: 3 kB / 0.9826 GB, free: 12.76 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0001861/1.124, allocations: 359.8 kB / 0.983 GB, free: 12.43 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0004531/1.125, allocations: 125.4 kB / 0.9831 GB, free: 12.41 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0005068/1.125, allocations: 218 kB / 0.9833 GB, free: 12.3 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0004855/1.126, allocations: 163.1 kB / 0.9834 GB, free: 12.28 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.759e-06/1.126, allocations: 0 / 0.9834 GB, free: 12.28 MB / 490.7 MB
Notification: Performance of matching and sorting (n=37) (initialization): time 0.001242/1.127, allocations: 406.5 kB / 0.9838 GB, free: 12.17 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001077/1.127, allocations: 137.2 kB / 0.984 GB, free: 12.02 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.086e-05/1.127, allocations: 3.312 kB / 0.984 GB, free: 12.02 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 2.023e-05/1.127, allocations: 3.156 kB / 0.984 GB, free: 12.02 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006175/1.128, allocations: 69.34 kB / 0.984 GB, free: 12.01 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.068e-05/1.128, allocations: 3 kB / 0.984 GB, free: 12.01 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009401/1.129, allocations: 64.27 kB / 0.9841 GB, free: 11.98 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.206e-05/1.129, allocations: 8.812 kB / 0.9841 GB, free: 11.98 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 1.065e-05/1.129, allocations: 7.781 kB / 0.9841 GB, free: 11.98 MB / 490.7 MB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001025/1.13, allocations: 342.3 kB / 0.9844 GB, free: 11.92 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.19e-06/1.13, allocations: 0 / 0.9844 GB, free: 11.92 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 9.528e-06/1.13, allocations: 5.406 kB / 0.9844 GB, free: 11.92 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0005784/1.131, allocations: 67.16 kB / 0.9845 GB, free: 11.91 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 8.526e-06/1.131, allocations: 2.875 kB / 0.9845 GB, free: 11.91 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0009148/1.132, allocations: 65.09 kB / 0.9846 GB, free: 11.88 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 4.507e-05/1.132, allocations: 11.94 kB / 0.9846 GB, free: 11.88 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 6
 * 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 (37):
 * 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: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0004755/1.132, allocations: 290.9 kB / 0.9849 GB, free: 11.67 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001403/1.132, allocations: 50 kB / 0.9849 GB, free: 11.64 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001301/1.134, allocations: 424.7 kB / 0.9853 GB, free: 11.52 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001128/1.135, allocations: 457.7 kB / 0.9858 GB, free: 11.29 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 4.498e-06/1.135, allocations: 0 / 0.9858 GB, free: 11.29 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003786/1.135, allocations: 155.9 kB / 0.9859 GB, free: 11.16 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001066/1.135, allocations: 12.05 kB / 0.9859 GB, free: 11.16 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007221/1.136, allocations: 39.36 kB / 0.986 GB, free: 11.14 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.569e-05/1.136, allocations: 21.62 kB / 0.986 GB, free: 11.13 MB / 490.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.001664/1.138, allocations: 0.4907 MB / 0.9865 GB, free: 10.93 MB / 490.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.001669/1.14, allocations: 0.7284 MB / 0.9872 GB, free: 10.62 MB / 490.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.0004393/1.14, allocations: 155.5 kB / 0.9873 GB, free: 10.59 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.0005548/1.141, allocations: 310.1 kB / 0.9876 GB, free: 10.46 MB / 490.7 MB
Notification: Performance of Backend: time 6.71e-07/1.141, allocations: 0 / 0.9876 GB, free: 10.46 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.002622/1.143, allocations: 0.6456 MB / 0.9882 GB, free: 10.25 MB / 490.7 MB
Notification: Performance of SimCode: time 0.00456/1.148, allocations: 1.931 MB / 0.9901 GB, free: 8.879 MB / 490.7 MB
Notification: Performance of Templates: time 0.03308/1.181, allocations: 11.92 MB / 1.002 GB, free: 2.922 MB / 490.7 MB