Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow.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.MixingVolumeHeatReverseFlow,tolerance=1e-08,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_master_IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow") Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001406/0.001409, allocations: 186.4 kB / 15.77 MB, free: 6 MB / 13.93 MB Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 0.7372/0.7372, allocations: 82.93 MB / 99.42 MB, free: 3.18 MB / 74.72 MB Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 2.175/2.175, allocations: 205.4 MB / 325.4 MB, free: 3.301 MB / 250.7 MB Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.001101/0.001101, allocations: 94.91 kB / 393.6 MB, free: 15.06 MB / 330.7 MB Notification: Performance of FrontEnd - loaded program: time 0.0004554/0.0004557, allocations: 12 kB / 471.5 MB, free: 66.52 MB / 362.7 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.08953/0.09001, allocations: 67.44 MB / 0.5263 GB, free: 15.04 MB / 378.7 MB Notification: Performance of NFInst.instantiate(IBPSA.Fluid.MixingVolumes.Validation.MixingVolumeHeatReverseFlow): time 0.6053/0.6954, allocations: 158.3 MB / 0.6809 GB, free: 0.7227 MB / 458.7 MB Notification: Performance of NFInst.instExpressions: time 0.01157/0.707, allocations: 5.62 MB / 0.6864 GB, free: 11.62 MB / 474.7 MB Notification: Performance of NFInst.updateImplicitVariability: time 0.001366/0.7084, allocations: 27.81 kB / 0.6864 GB, free: 11.6 MB / 474.7 MB Notification: Performance of NFTyping.typeComponents: time 0.002123/0.7106, allocations: 0.5793 MB / 0.687 GB, free: 11.02 MB / 474.7 MB Notification: Performance of NFTyping.typeBindings: time 0.006339/0.7169, allocations: 1.637 MB / 0.6886 GB, free: 9.375 MB / 474.7 MB Notification: Performance of NFTyping.typeClassSections: time 0.004808/0.7218, allocations: 1.189 MB / 0.6897 GB, free: 8.199 MB / 474.7 MB Notification: Performance of NFFlatten.flatten: time 0.00368/0.7255, allocations: 1.66 MB / 0.6914 GB, free: 6.539 MB / 474.7 MB Notification: Performance of NFFlatten.resolveConnections: time 0.00146/0.727, allocations: 0.7182 MB / 0.6921 GB, free: 5.809 MB / 474.7 MB Notification: Performance of NFEvalConstants.evaluate: time 0.001895/0.7289, allocations: 0.7669 MB / 0.6928 GB, free: 5.039 MB / 474.7 MB Notification: Performance of NFSimplifyModel.simplify: time 0.001166/0.7301, allocations: 0.5603 MB / 0.6934 GB, free: 4.477 MB / 474.7 MB Notification: Performance of NFPackage.collectConstants: time 0.0001804/0.7303, allocations: 40 kB / 0.6934 GB, free: 4.438 MB / 474.7 MB Notification: Performance of NFFlatten.collectFunctions: time 0.00225/0.7325, allocations: 0.6201 MB / 0.694 GB, free: 3.816 MB / 474.7 MB Notification: Performance of NFScalarize.scalarize: time 0.0005522/0.7331, allocations: 359 kB / 0.6943 GB, free: 3.465 MB / 474.7 MB Notification: Performance of NFVerifyModel.verify: time 0.0004938/0.7336, allocations: 261.1 kB / 0.6946 GB, free: 3.203 MB / 474.7 MB Notification: Performance of NFConvertDAE.convert: time 0.002466/0.7361, allocations: 1.383 MB / 0.6959 GB, free: 1.816 MB / 474.7 MB Notification: Performance of FrontEnd - DAE generated: time 3.685e-06/0.7361, allocations: 0 / 0.6959 GB, free: 1.816 MB / 474.7 MB Notification: Performance of FrontEnd: time 7.928e-06/0.7362, allocations: 4 kB / 0.6959 GB, free: 1.812 MB / 474.7 MB Notification: Performance of Transformations before backend: time 2.257e-05/0.7362, allocations: 0 / 0.6959 GB, free: 1.812 MB / 474.7 MB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 213 * Number of variables: 213 Notification: Performance of Generate backend data structure: time 0.002781/0.739, allocations: 1.274 MB / 0.6972 GB, free: 496 kB / 474.7 MB Notification: Performance of prepare preOptimizeDAE: time 4.169e-05/0.739, allocations: 8.031 kB / 0.6972 GB, free: 488 kB / 474.7 MB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002747/0.7418, allocations: 318.3 kB / 0.6975 GB, free: 168 kB / 474.7 MB Notification: Performance of preOpt evaluateParameters (simulation): time 0.001978/0.7438, allocations: 0.7692 MB / 0.6982 GB, free: 15.36 MB / 490.7 MB Notification: Performance of preOpt simplifyIfEquations (simulation): time 9.121e-05/0.7439, allocations: 69.98 kB / 0.6983 GB, free: 15.29 MB / 490.7 MB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001882/0.7441, allocations: 80 kB / 0.6984 GB, free: 15.21 MB / 490.7 MB Notification: Performance of preOpt clockPartitioning (simulation): time 0.002338/0.7465, allocations: 0.9092 MB / 0.6993 GB, free: 14.29 MB / 490.7 MB Notification: Performance of preOpt findStateOrder (simulation): time 3.015e-05/0.7466, allocations: 0 / 0.6993 GB, free: 14.29 MB / 490.7 MB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001357/0.7467, allocations: 40 kB / 0.6993 GB, free: 14.25 MB / 490.7 MB Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.325e-05/0.7468, allocations: 30 kB / 0.6993 GB, free: 14.23 MB / 490.7 MB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002131/0.7489, allocations: 0.8276 MB / 0.7002 GB, free: 13.39 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.007878/0.7568, allocations: 3.536 MB / 0.7036 GB, free: 9.641 MB / 490.7 MB Notification: Performance of preOpt comSubExp (simulation): time 0.001167/0.758, allocations: 0.4926 MB / 0.7041 GB, free: 9.137 MB / 490.7 MB Notification: Performance of preOpt evalFunc (simulation): time 8.401e-05/0.7582, allocations: 20.41 kB / 0.7041 GB, free: 9.117 MB / 490.7 MB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.588e-05/0.7582, allocations: 43 kB / 0.7041 GB, free: 9.066 MB / 490.7 MB Notification: Performance of pre-optimization done (n=47): time 4.07e-06/0.7582, allocations: 4 kB / 0.7042 GB, free: 9.062 MB / 490.7 MB Notification: Performance of matching and sorting (n=49): time 0.005713/0.764, allocations: 1.931 MB / 0.706 GB, free: 7.039 MB / 490.7 MB Notification: Performance of inlineWhenForInitialization (initialization): time 5.357e-05/0.764, allocations: 59.84 kB / 0.7061 GB, free: 6.965 MB / 490.7 MB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001469/0.7655, allocations: 0.7901 MB / 0.7069 GB, free: 6.168 MB / 490.7 MB Notification: Performance of collectPreVariables (initialization): time 0.0001192/0.7657, allocations: 41.7 kB / 0.7069 GB, free: 6.121 MB / 490.7 MB Notification: Performance of collectInitialEqns (initialization): time 0.0004933/0.7662, allocations: 467.4 kB / 0.7074 GB, free: 5.656 MB / 490.7 MB Notification: Performance of collectInitialBindings (initialization): time 0.0002468/0.7664, allocations: 169.5 kB / 0.7075 GB, free: 5.488 MB / 490.7 MB Notification: Performance of simplifyInitialFunctions (initialization): time 4.662e-05/0.7665, allocations: 12 kB / 0.7075 GB, free: 5.477 MB / 490.7 MB Notification: Performance of setup shared object (initialization): time 0.0001837/0.7667, allocations: 330 kB / 0.7078 GB, free: 5.148 MB / 490.7 MB Notification: Performance of preBalanceInitialSystem (initialization): time 0.0006578/0.7674, allocations: 253 kB / 0.7081 GB, free: 4.898 MB / 490.7 MB Notification: Performance of partitionIndependentBlocks (initialization): time 0.0007717/0.7682, allocations: 363 kB / 0.7084 GB, free: 4.504 MB / 490.7 MB Warning: It was not possible to determine if the initialization problem is consistent, because of not evaluable parameters/start values during compile time: volDyn.dynBal.medium.p = volDyn.dynBal.p_start (bou.p = volDyn.dynBal.p_start) Notification: Performance of analyzeInitialSystem (initialization): time 0.003895/0.7721, allocations: 1.01 MB / 0.7094 GB, free: 3.477 MB / 490.7 MB Notification: Performance of solveInitialSystemEqSystem (initialization): time 5.856e-06/0.7721, allocations: 0 / 0.7094 GB, free: 3.477 MB / 490.7 MB Notification: Performance of matching and sorting (n=72) (initialization): time 0.002035/0.7741, allocations: 0.7884 MB / 0.7102 GB, free: 2.676 MB / 490.7 MB Notification: Performance of prepare postOptimizeDAE: time 2.684e-05/0.7742, allocations: 4.625 kB / 0.7102 GB, free: 2.672 MB / 490.7 MB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.49e-05/0.7742, allocations: 8 kB / 0.7102 GB, free: 2.664 MB / 490.7 MB Notification: Performance of postOpt tearingSystem (initialization): time 0.0004158/0.7747, allocations: 102 kB / 0.7103 GB, free: 2.559 MB / 490.7 MB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008515/0.7755, allocations: 147.8 kB / 0.7104 GB, free: 2.414 MB / 490.7 MB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.004241/0.7798, allocations: 3.1 MB / 0.7135 GB, free: 15.04 MB / 0.4948 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001166/0.781, allocations: 60.62 kB / 0.7135 GB, free: 14.98 MB / 0.4948 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 8.248e-05/0.7811, allocations: 24 kB / 0.7135 GB, free: 14.96 MB / 0.4948 GB Warning: The initial conditions are over specified. The following 1 initial equations are redundant, so they are removed from the initialization sytem: volDyn.dynBal.medium.p = volDyn.dynBal.p_start. Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 12 * 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 (67): * Single equations (assignments): 65 * 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 {1 4,1 1} Notification: Performance of prepare postOptimizeDAE: time 0.0006902/0.7818, allocations: 310.6 kB / 0.7138 GB, free: 14.65 MB / 0.4948 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0002472/0.7821, allocations: 90.97 kB / 0.7139 GB, free: 14.56 MB / 0.4948 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0002321/0.7823, allocations: 96.47 kB / 0.714 GB, free: 14.46 MB / 0.4948 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.46e-05/0.7823, allocations: 8 kB / 0.714 GB, free: 14.45 MB / 0.4948 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 1.004e-05/0.7824, allocations: 3.953 kB / 0.714 GB, free: 14.45 MB / 0.4948 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001542/0.7839, allocations: 0.8543 MB / 0.7149 GB, free: 13.5 MB / 0.4948 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.004285/0.7882, allocations: 1.794 MB / 0.7166 GB, free: 11.61 MB / 0.4948 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.135e-05/0.7883, allocations: 4 kB / 0.7166 GB, free: 11.61 MB / 0.4948 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008164/0.7891, allocations: 144.2 kB / 0.7168 GB, free: 11.46 MB / 0.4948 GB Notification: Performance of postOpt tearingSystem (simulation): time 0.0003249/0.7894, allocations: 68.81 kB / 0.7168 GB, free: 11.39 MB / 0.4948 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.569e-05/0.7895, allocations: 15.98 kB / 0.7168 GB, free: 11.38 MB / 0.4948 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002353/0.7919, allocations: 1.675 MB / 0.7185 GB, free: 9.574 MB / 0.4948 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.796e-06/0.7919, allocations: 7.969 kB / 0.7185 GB, free: 9.566 MB / 0.4948 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002569/0.7945, allocations: 1.255 MB / 0.7197 GB, free: 8.176 MB / 0.4948 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0006609/0.7952, allocations: 231.9 kB / 0.7199 GB, free: 7.93 MB / 0.4948 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001621/0.7954, allocations: 19.98 kB / 0.7199 GB, free: 7.91 MB / 0.4948 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001002/0.7964, allocations: 57.66 kB / 0.72 GB, free: 7.855 MB / 0.4948 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001488/0.7966, allocations: 51.84 kB / 0.7201 GB, free: 7.805 MB / 0.4948 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 8.972e-05/0.7967, allocations: 27.98 kB / 0.7201 GB, free: 7.777 MB / 0.4948 GB Notification: Performance of sorting global known variables: time 0.001072/0.7978, allocations: 0.5497 MB / 0.7206 GB, free: 7.23 MB / 0.4948 GB Notification: Performance of sort global known variables: time 1.026e-06/0.7978, allocations: 0 / 0.7206 GB, free: 7.23 MB / 0.4948 GB Notification: Performance of remove unused functions: time 0.00132/0.7991, allocations: 284 kB / 0.7209 GB, free: 6.953 MB / 0.4948 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 14 * Number of states: 2 (volDyn.dynBal.U,volDyn.dynBal.mXi[1]) * 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 (45): * Single equations (assignments): 44 * 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: 1 * Mixed (continuous/discrete) equation systems: 0 Notification: Torn system details for strict tearing set: * Linear torn systems: 0 * Non-linear torn systems: 1 {1 4} Notification: Performance of Backend phase and start with SimCode phase: time 0.0005563/0.7997, allocations: 193.6 kB / 0.7211 GB, free: 6.766 MB / 0.4948 GB Notification: Performance of simCode: created initialization part: time 0.001893/0.8016, allocations: 0.8042 MB / 0.7219 GB, free: 5.938 MB / 0.4948 GB Notification: Performance of simCode: created event and clocks part: time 9.009e-06/0.8016, allocations: 7.938 kB / 0.7219 GB, free: 5.93 MB / 0.4948 GB Notification: Performance of simCode: created simulation system equations: time 0.0008649/0.8025, allocations: 419.6 kB / 0.7223 GB, free: 5.508 MB / 0.4948 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003344/0.8059, allocations: 0.579 MB / 0.7228 GB, free: 4.941 MB / 0.4948 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.004233/0.8101, allocations: 2.13 MB / 0.7249 GB, free: 2.746 MB / 0.4948 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00104/0.8112, allocations: 1.103 MB / 0.726 GB, free: 1.613 MB / 0.4948 GB Notification: Performance of simCode: alias equations: time 0.001362/0.8126, allocations: 207.5 kB / 0.7262 GB, free: 1.406 MB / 0.4948 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002825/0.8129, allocations: 67.44 kB / 0.7262 GB, free: 1.34 MB / 0.4948 GB Notification: Performance of SimCode: time 1.859e-06/0.8129, allocations: 0 / 0.7262 GB, free: 1.34 MB / 0.4948 GB Notification: Performance of Templates: time 0.06638/0.8793, allocations: 18.94 MB / 0.7447 GB, free: 14.56 MB / 0.5261 GB