Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.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/BuildSysPro 3.6.0/package.mo", uses=false) Using package BuildSysPro with version 3.5.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/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(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume,tolerance=1e-09,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume") translateModel(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume,tolerance=1e-09,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume") Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001465/0.001465, allocations: 111.3 kB / 15.23 MB, free: 0.6406 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.001789/0.001789, allocations: 193.9 kB / 16.14 MB, free: 6.688 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.388/1.388, allocations: 222.9 MB / 239.8 MB, free: 4.613 MB / 190.1 MB [/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo. Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.6.0/package.mo): time 1.002/1.002, allocations: 143 MB / 433 MB, free: 11.68 MB / 350.1 MB Notification: Performance of FrontEnd - loaded program: time 0.001348/0.001348, allocations: 59.89 kB / 0.5135 GB, free: 12.16 MB / 430.1 MB Notification: Performance of FrontEnd - Absyn->SCode: time 0.1705/0.1719, allocations: 82.05 MB / 0.5936 GB, free: 10.08 MB / 0.4981 GB Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume): time 0.6022/0.7741, allocations: 240.6 MB / 0.8286 GB, free: 12.99 MB / 0.6544 GB Notification: Performance of NFInst.instExpressions: time 0.02173/0.7958, allocations: 16.13 MB / 0.8443 GB, free: 12.82 MB / 0.67 GB Notification: Performance of NFInst.updateImplicitVariability: time 0.003369/0.7993, allocations: 71.5 kB / 0.8444 GB, free: 12.75 MB / 0.67 GB Notification: Performance of NFTyping.typeComponents: time 0.003275/0.8026, allocations: 1.014 MB / 0.8454 GB, free: 11.73 MB / 0.67 GB Notification: Performance of NFTyping.typeBindings: time 0.009866/0.8125, allocations: 3.607 MB / 0.8489 GB, free: 8.117 MB / 0.67 GB Notification: Performance of NFTyping.typeClassSections: time 0.004621/0.8171, allocations: 1.614 MB / 0.8505 GB, free: 6.512 MB / 0.67 GB Notification: Performance of NFFlatten.flatten: time 0.4129/1.23, allocations: 7.416 MB / 0.8577 GB, free: 5.074 MB / 0.67 GB Notification: Performance of NFFlatten.resolveConnections: time 0.002879/1.233, allocations: 1.413 MB / 0.8591 GB, free: 4.93 MB / 0.67 GB Notification: Performance of NFEvalConstants.evaluate: time 0.005997/1.239, allocations: 2.337 MB / 0.8614 GB, free: 4.922 MB / 0.67 GB Notification: Performance of NFSimplifyModel.simplify: time 0.004639/1.244, allocations: 1.782 MB / 0.8631 GB, free: 4.918 MB / 0.67 GB Notification: Performance of NFPackage.collectConstants: time 0.0007719/1.244, allocations: 100.5 kB / 0.8632 GB, free: 4.918 MB / 0.67 GB Notification: Performance of NFFlatten.collectFunctions: time 0.007123/1.252, allocations: 3.145 MB / 0.8663 GB, free: 4.918 MB / 0.67 GB Notification: Performance of NFScalarize.scalarize: time 0.001523/1.253, allocations: 0.7019 MB / 0.867 GB, free: 4.918 MB / 0.67 GB Notification: Performance of NFVerifyModel.verify: time 0.003654/1.257, allocations: 1.072 MB / 0.868 GB, free: 4.914 MB / 0.67 GB Notification: Performance of NFConvertDAE.convert: time 0.007689/1.264, allocations: 3.745 MB / 0.8717 GB, free: 4.82 MB / 0.67 GB Notification: Performance of FrontEnd - DAE generated: time 5.891e-06/1.265, allocations: 0 / 0.8717 GB, free: 4.82 MB / 0.67 GB Notification: Performance of FrontEnd: time 1.393e-06/1.265, allocations: 0 / 0.8717 GB, free: 4.82 MB / 0.67 GB Notification: Performance of Transformations before backend: time 0.0001057/1.265, allocations: 0.9375 kB / 0.8717 GB, free: 4.82 MB / 0.67 GB Notification: Model statistics after passing the front-end and creating the data structures used by the back-end: * Number of equations: 363 * Number of variables: 363 Notification: Performance of Generate backend data structure: time 0.005421/1.27, allocations: 2.508 MB / 0.8741 GB, free: 19.67 MB / 0.6856 GB Notification: Performance of prepare preOptimizeDAE: time 4.287e-05/1.27, allocations: 10.47 kB / 0.8741 GB, free: 19.67 MB / 0.6856 GB Notification: Performance of preOpt normalInlineFunction (simulation): time 0.003169/1.273, allocations: 0.5053 MB / 0.8746 GB, free: 19.55 MB / 0.6856 GB Notification: Performance of preOpt evaluateParameters (simulation): time 0.00247/1.276, allocations: 1.275 MB / 0.8759 GB, free: 19.1 MB / 0.6856 GB Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001668/1.276, allocations: 178.2 kB / 0.8761 GB, free: 19.04 MB / 0.6856 GB Notification: Performance of preOpt expandDerOperator (simulation): time 0.0002609/1.276, allocations: 152.3 kB / 0.8762 GB, free: 19.04 MB / 0.6856 GB Notification: Performance of preOpt clockPartitioning (simulation): time 0.003265/1.28, allocations: 1.735 MB / 0.8779 GB, free: 18.8 MB / 0.6856 GB Notification: Performance of preOpt findStateOrder (simulation): time 3.947e-05/1.28, allocations: 4.531 kB / 0.8779 GB, free: 18.8 MB / 0.6856 GB Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0001469/1.28, allocations: 66.11 kB / 0.878 GB, free: 18.8 MB / 0.6856 GB Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.717e-05/1.28, allocations: 68.34 kB / 0.878 GB, free: 18.8 MB / 0.6856 GB Notification: Performance of preOpt removeEqualRHS (simulation): time 0.002876/1.283, allocations: 1.37 MB / 0.8794 GB, free: 18.78 MB / 0.6856 GB 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.0112/1.294, allocations: 8.194 MB / 0.8874 GB, free: 13.94 MB / 0.6856 GB Notification: Performance of preOpt comSubExp (simulation): time 0.001901/1.296, allocations: 0.894 MB / 0.8882 GB, free: 13.91 MB / 0.6856 GB Notification: Performance of preOpt resolveLoops (simulation): time 0.001068/1.297, allocations: 0.5403 MB / 0.8888 GB, free: 13.89 MB / 0.6856 GB Notification: Performance of preOpt evalFunc (simulation): time 0.0007501/1.298, allocations: 320.7 kB / 0.8891 GB, free: 13.61 MB / 0.6856 GB Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.872e-05/1.298, allocations: 50.03 kB / 0.8891 GB, free: 13.57 MB / 0.6856 GB Notification: Performance of pre-optimization done (n=96): time 3.757e-06/1.298, allocations: 0 / 0.8891 GB, free: 13.57 MB / 0.6856 GB Notification: Performance of matching and sorting (n=102): time 0.009296/1.307, allocations: 3.111 MB / 0.8922 GB, free: 12.95 MB / 0.6856 GB Notification: Performance of inlineWhenForInitialization (initialization): time 7.051e-05/1.307, allocations: 68.95 kB / 0.8922 GB, free: 12.88 MB / 0.6856 GB Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.002463/1.31, allocations: 1.258 MB / 0.8935 GB, free: 12.71 MB / 0.6856 GB Notification: Performance of collectPreVariables (initialization): time 0.0001788/1.31, allocations: 51.8 kB / 0.8935 GB, free: 12.68 MB / 0.6856 GB Notification: Performance of collectInitialEqns (initialization): time 0.0007791/1.311, allocations: 0.8149 MB / 0.8943 GB, free: 12.36 MB / 0.6856 GB Notification: Performance of collectInitialBindings (initialization): time 0.0005347/1.311, allocations: 366.1 kB / 0.8946 GB, free: 12.13 MB / 0.6856 GB Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005379/1.312, allocations: 226.2 kB / 0.8949 GB, free: 12.11 MB / 0.6856 GB Notification: Performance of setup shared object (initialization): time 0.0002297/1.312, allocations: 357.6 kB / 0.8952 GB, free: 11.8 MB / 0.6856 GB Notification: Performance of preBalanceInitialSystem (initialization): time 0.001088/1.313, allocations: 447.2 kB / 0.8956 GB, free: 11.79 MB / 0.6856 GB Notification: Performance of partitionIndependentBlocks (initialization): time 0.001171/1.314, allocations: 0.8273 MB / 0.8964 GB, free: 11.34 MB / 0.6856 GB Notification: Performance of analyzeInitialSystem (initialization): time 0.002015/1.316, allocations: 1.25 MB / 0.8977 GB, free: 10.99 MB / 0.6856 GB Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.063e-05/1.316, allocations: 10.19 kB / 0.8977 GB, free: 10.98 MB / 0.6856 GB Notification: Performance of matching and sorting (n=150) (initialization): time 0.00314/1.319, allocations: 1.407 MB / 0.899 GB, free: 10.86 MB / 0.6856 GB Notification: Performance of prepare postOptimizeDAE: time 3.501e-05/1.32, allocations: 9.531 kB / 0.8991 GB, free: 10.86 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.857e-05/1.32, allocations: 10.94 kB / 0.8991 GB, free: 10.86 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (initialization): time 3.598e-05/1.32, allocations: 15.16 kB / 0.8991 GB, free: 10.86 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001292/1.321, allocations: 277.9 kB / 0.8993 GB, free: 10.86 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 4.155e-05/1.321, allocations: 20.95 kB / 0.8994 GB, free: 10.86 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002587/1.324, allocations: 166.7 kB / 0.8995 GB, free: 10.83 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001405/1.324, allocations: 54.09 kB / 0.8996 GB, free: 10.83 MB / 0.6856 GB Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.002049/1.326, allocations: 0.7756 MB / 0.9003 GB, free: 10.75 MB / 0.6856 GB Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.001129/1.327, allocations: 0.8145 MB / 0.9011 GB, free: 10.3 MB / 0.6856 GB Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001942/1.329, allocations: 1.238 MB / 0.9023 GB, free: 9.949 MB / 0.6856 GB Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 1.1e-05/1.329, allocations: 8.141 kB / 0.9023 GB, free: 9.945 MB / 0.6856 GB Notification: Performance of matching and sorting (n=150) (initialization_lambda0): time 0.003189/1.332, allocations: 1.393 MB / 0.9037 GB, free: 9.805 MB / 0.6856 GB Notification: Performance of prepare postOptimizeDAE: time 2.585e-05/1.332, allocations: 10.88 kB / 0.9037 GB, free: 9.805 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.491e-05/1.332, allocations: 8.438 kB / 0.9037 GB, free: 9.805 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (initialization): time 1.871e-05/1.332, allocations: 14.25 kB / 0.9037 GB, free: 9.805 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001087/1.333, allocations: 272.4 kB / 0.904 GB, free: 9.805 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 2.255e-05/1.333, allocations: 21.72 kB / 0.904 GB, free: 9.805 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002017/1.335, allocations: 180.1 kB / 0.9042 GB, free: 9.781 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.982e-05/1.335, allocations: 48.88 kB / 0.9042 GB, free: 9.781 MB / 0.6856 GB Notification: Model statistics after passing the back-end for initialization: * Number of independent subsystems: 41 * Number of states: 0 () * Number of discrete variables: 4 (vol.regularFlow[1],vol.regularFlow[2],vol.inFlow[2],vol.inFlow[1]) * Number of discrete states: 0 () * Number of clocked states: 0 () * Top-level inputs: 0 Notification: Strong component statistics for initialization (150): * Single equations (assignments): 150 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of prepare postOptimizeDAE: time 0.0005802/1.336, allocations: 270.7 kB / 0.9045 GB, free: 9.586 MB / 0.6856 GB Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0003064/1.336, allocations: 162.3 kB / 0.9046 GB, free: 9.504 MB / 0.6856 GB Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.002435/1.339, allocations: 1.154 MB / 0.9058 GB, free: 9.426 MB / 0.6856 GB Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.043e-05/1.339, allocations: 14.31 kB / 0.9058 GB, free: 9.422 MB / 0.6856 GB Notification: Performance of postOpt constantLinearSystem (simulation): time 7.815e-06/1.339, allocations: 0 / 0.9058 GB, free: 9.422 MB / 0.6856 GB Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.00164/1.34, allocations: 1.08 MB / 0.9068 GB, free: 9.152 MB / 0.6856 GB Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.005252/1.346, allocations: 2.798 MB / 0.9096 GB, free: 8.746 MB / 0.6856 GB Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.831e-06/1.346, allocations: 2.719 kB / 0.9096 GB, free: 8.746 MB / 0.6856 GB Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.001175/1.347, allocations: 245 kB / 0.9098 GB, free: 8.742 MB / 0.6856 GB Notification: Performance of postOpt tearingSystem (simulation): time 1.048e-05/1.347, allocations: 6.906 kB / 0.9098 GB, free: 8.742 MB / 0.6856 GB Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.06e-05/1.347, allocations: 32.17 kB / 0.9098 GB, free: 8.742 MB / 0.6856 GB Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 7.735e-06/1.347, allocations: 3.734 kB / 0.9099 GB, free: 8.742 MB / 0.6856 GB Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 2.875e-06/1.347, allocations: 2.906 kB / 0.9099 GB, free: 8.742 MB / 0.6856 GB Notification: Performance of postOpt symbolicJacobian (simulation): time 0.00279/1.35, allocations: 1.766 MB / 0.9116 GB, free: 8.426 MB / 0.6856 GB Notification: Performance of postOpt removeConstants (simulation): time 0.0008707/1.351, allocations: 338.4 kB / 0.9119 GB, free: 8.246 MB / 0.6856 GB Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0002164/1.351, allocations: 23.02 kB / 0.9119 GB, free: 8.246 MB / 0.6856 GB Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001288/1.352, allocations: 148.3 kB / 0.9121 GB, free: 8.219 MB / 0.6856 GB Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001542/1.352, allocations: 63.72 kB / 0.9121 GB, free: 8.219 MB / 0.6856 GB Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.432e-05/1.352, allocations: 34 kB / 0.9122 GB, free: 8.219 MB / 0.6856 GB Notification: Performance of sorting global known variables: time 0.001086/1.354, allocations: 0.8475 MB / 0.913 GB, free: 8.109 MB / 0.6856 GB Notification: Performance of sort global known variables: time 1.6e-07/1.354, allocations: 1.641 kB / 0.913 GB, free: 8.109 MB / 0.6856 GB Notification: Performance of remove unused functions: time 0.002128/1.356, allocations: 0.7594 MB / 0.9137 GB, free: 8.105 MB / 0.6856 GB Notification: Model statistics after passing the back-end for simulation: * Number of independent subsystems: 8 * Number of states: 9 (vol1.dynBal.medium.Xi[1],vol1.dynBal.U,vol1.dynBal.m,vol.medium.Xi[1],vol.medium.T,vol.m,vol2.dynBal.medium.Xi[1],vol2.dynBal.U,vol2.dynBal.m) * 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 (102): * Single equations (assignments): 102 * Array equations: 0 * Algorithm blocks: 0 * Record equations: 0 * When equations: 0 * If-equations: 0 * Equation systems (not torn): 0 * Torn equation systems: 0 * Mixed (continuous/discrete) equation systems: 0 Notification: Performance of Backend phase and start with SimCode phase: time 0.0005904/1.356, allocations: 286.1 kB / 0.914 GB, free: 7.992 MB / 0.6856 GB Notification: Performance of simCode: created initialization part: time 0.00293/1.359, allocations: 1.735 MB / 0.9157 GB, free: 7.957 MB / 0.6856 GB Notification: Performance of simCode: created event and clocks part: time 5.961e-06/1.359, allocations: 8 kB / 0.9157 GB, free: 7.949 MB / 0.6856 GB Notification: Performance of simCode: created simulation system equations: time 0.0008103/1.36, allocations: 0.5144 MB / 0.9162 GB, free: 7.945 MB / 0.6856 GB Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.004622/1.365, allocations: 0.9659 MB / 0.9172 GB, free: 7.887 MB / 0.6856 GB Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.006082/1.371, allocations: 4.171 MB / 0.9212 GB, free: 5.645 MB / 0.6856 GB Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001/1.372, allocations: 1.443 MB / 0.9226 GB, free: 4.898 MB / 0.6856 GB Notification: Performance of simCode: alias equations: time 0.002167/1.374, allocations: 0.56 MB / 0.9232 GB, free: 4.789 MB / 0.6856 GB Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0003699/1.374, allocations: 130 kB / 0.9233 GB, free: 4.781 MB / 0.6856 GB Notification: Performance of SimCode: time 6.81e-07/1.374, allocations: 0 / 0.9233 GB, free: 4.781 MB / 0.6856 GB Notification: Performance of Templates: time 0.04874/1.423, allocations: 30.48 MB / 0.9531 GB, free: 480 kB / 0.7012 GB make -j1 -f BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.makefile (rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.sim & ./BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildSysPro_BuildSysPro.IBPSA.Fluid.MixingVolumes.Validation.MixingVolume.pipe 2>&1)