Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.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/NcDataReader2 2.5.1-master/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo", uses=false)
Using package BuildingSystems with version 2.0.0-beta (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo)
Using package NcDataReader2 with version 2.5.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/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(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization")
translateModel(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007776/0.0007777, allocations: 91.61 kB / 15.06 MB, free: 1.098 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.0008373/0.0008375, allocations: 172.7 kB / 15.95 MB, free: 208 kB / 14.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.312/1.312, allocations: 223.3 MB / 240 MB, free: 5.387 MB / 190.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/NcDataReader2 2.5.1-master/package.mo): time 0.001744/0.001744, allocations: 274.5 kB / 291.3 MB, free: 1.945 MB / 238.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildingSystems 2.0.0-master/package.mo): time 0.95/0.95, allocations: 169.5 MB / 0.5 GB, free: 14.23 MB / 382.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.000391/0.000391, allocations: 15.06 kB / 0.598 GB, free: 28.27 MB / 430.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1305/0.1309, allocations: 88.55 MB / 0.6845 GB, free: 15.48 MB / 494.1 MB
Notification: Performance of NFInst.instantiate(BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization): time 0.4267/0.5576, allocations: 171.4 MB / 0.8519 GB, free: 12.89 MB / 0.5762 GB
Notification: Performance of NFInst.instExpressions: time 0.01289/0.5706, allocations: 10.16 MB / 0.8618 GB, free: 4.711 MB / 0.5762 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00109/0.5717, allocations: 45.28 kB / 0.8618 GB, free: 4.688 MB / 0.5762 GB
Notification: Performance of NFTyping.typeComponents: time 0.0009988/0.5727, allocations: 353.9 kB / 0.8622 GB, free: 4.391 MB / 0.5762 GB
Notification: Performance of NFTyping.typeBindings: time 0.00463/0.5774, allocations: 1.962 MB / 0.8641 GB, free: 2.914 MB / 0.5762 GB
Notification: Performance of NFTyping.typeClassSections: time 0.004317/0.5817, allocations: 1.895 MB / 0.8659 GB, free: 1.668 MB / 0.5762 GB
Notification: Performance of NFFlatten.flatten: time 0.00335/0.5851, allocations: 3.316 MB / 0.8692 GB, free: 15.71 MB / 0.5919 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0008758/0.5859, allocations: 0.5838 MB / 0.8697 GB, free: 15.35 MB / 0.5919 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.001376/0.5873, allocations: 0.8971 MB / 0.8706 GB, free: 14.9 MB / 0.5919 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.001408/0.5888, allocations: 1.017 MB / 0.8716 GB, free: 14.36 MB / 0.5919 GB
Notification: Performance of NFPackage.collectConstants: time 0.0001105/0.5889, allocations: 43.41 kB / 0.8717 GB, free: 14.36 MB / 0.5919 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.00394/0.5928, allocations: 2.061 MB / 0.8737 GB, free: 13.25 MB / 0.5919 GB
Notification: Performance of NFScalarize.scalarize: time 0.0004174/0.5933, allocations: 383.8 kB / 0.874 GB, free: 13.01 MB / 0.5919 GB
Notification: Performance of NFVerifyModel.verify: time 0.0002914/0.5936, allocations: 234.6 kB / 0.8743 GB, free: 12.88 MB / 0.5919 GB
Notification: Performance of NFConvertDAE.convert: time 0.002369/0.5959, allocations: 1.976 MB / 0.8762 GB, free: 11.71 MB / 0.5919 GB
Notification: Performance of FrontEnd - DAE generated: time 3.667e-06/0.5959, allocations: 0 / 0.8762 GB, free: 11.71 MB / 0.5919 GB
Notification: Performance of FrontEnd: time 1.884e-06/0.596, allocations: 0 / 0.8762 GB, free: 11.71 MB / 0.5919 GB
Notification: Performance of Transformations before backend: time 1.316e-05/0.596, allocations: 0 / 0.8762 GB, free: 11.71 MB / 0.5919 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 173
 * Number of variables: 173
Notification: Performance of Generate backend data structure: time 0.002921/0.5989, allocations: 1.482 MB / 0.8776 GB, free: 10.49 MB / 0.5919 GB
Notification: Performance of prepare preOptimizeDAE: time 3.743e-05/0.5989, allocations: 12.02 kB / 0.8776 GB, free: 10.48 MB / 0.5919 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.001806/0.6008, allocations: 290.5 kB / 0.8779 GB, free: 10.19 MB / 0.5919 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001186/0.602, allocations: 0.746 MB / 0.8787 GB, free: 9.406 MB / 0.5919 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.198e-05/0.602, allocations: 53.3 kB / 0.8787 GB, free: 9.352 MB / 0.5919 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001141/0.6021, allocations: 63.98 kB / 0.8788 GB, free: 9.289 MB / 0.5919 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001619/0.6038, allocations: 0.9844 MB / 0.8797 GB, free: 8.289 MB / 0.5919 GB
Notification: Performance of preOpt findStateOrder (simulation): time 1.866e-05/0.6038, allocations: 7.938 kB / 0.8797 GB, free: 8.281 MB / 0.5919 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 7.9e-05/0.6039, allocations: 31.94 kB / 0.8798 GB, free: 8.25 MB / 0.5919 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 9.63e-05/0.604, allocations: 81.88 kB / 0.8798 GB, free: 8.172 MB / 0.5919 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001655/0.6056, allocations: 1.019 MB / 0.8808 GB, free: 7.148 MB / 0.5919 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.00562/0.6113, allocations: 3.587 MB / 0.8843 GB, free: 3.332 MB / 0.5919 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001087/0.6124, allocations: 0.6626 MB / 0.885 GB, free: 2.66 MB / 0.5919 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005531/0.613, allocations: 373 kB / 0.8853 GB, free: 2.297 MB / 0.5919 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002682/0.6132, allocations: 202.7 kB / 0.8855 GB, free: 2.062 MB / 0.5919 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 2.56e-05/0.6133, allocations: 43.06 kB / 0.8856 GB, free: 2.012 MB / 0.5919 GB
Notification: Performance of pre-optimization done (n=62): time 2.504e-06/0.6133, allocations: 0 / 0.8856 GB, free: 2.012 MB / 0.5919 GB
Notification: Performance of matching and sorting (n=62): time 0.001911/0.6152, allocations: 1.029 MB / 0.8866 GB, free: 0.9805 MB / 0.5919 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 5.515e-05/0.6153, allocations: 111.3 kB / 0.8867 GB, free: 0.8477 MB / 0.5919 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0009856/0.6163, allocations: 0.8019 MB / 0.8875 GB, free: 40 kB / 0.5919 GB
Notification: Performance of collectPreVariables (initialization): time 7.174e-05/0.6163, allocations: 37.75 kB / 0.8875 GB, free: 15.99 MB / 0.6075 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003141/0.6167, allocations: 416.1 kB / 0.8879 GB, free: 15.58 MB / 0.6075 GB
Notification: Performance of collectInitialBindings (initialization): time 0.000215/0.6169, allocations: 220.8 kB / 0.8881 GB, free: 15.36 MB / 0.6075 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 4.714e-05/0.6169, allocations: 16 kB / 0.8881 GB, free: 15.35 MB / 0.6075 GB
Notification: Performance of setup shared object (initialization): time 0.0001115/0.6171, allocations: 334 kB / 0.8884 GB, free: 15.02 MB / 0.6075 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005209/0.6176, allocations: 325.8 kB / 0.8888 GB, free: 14.7 MB / 0.6075 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.0006131/0.6182, allocations: 460.7 kB / 0.8892 GB, free: 14.21 MB / 0.6075 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.0006073/0.6188, allocations: 395 kB / 0.8896 GB, free: 13.82 MB / 0.6075 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.426e-06/0.6188, allocations: 0 / 0.8896 GB, free: 13.82 MB / 0.6075 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.001463/0.6203, allocations: 0.9099 MB / 0.8905 GB, free: 12.91 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 8.897e-05/0.6204, allocations: 159.6 kB / 0.8906 GB, free: 12.72 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.254e-06/0.6204, allocations: 4 kB / 0.8906 GB, free: 12.71 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.871e-05/0.6204, allocations: 8 kB / 0.8906 GB, free: 12.71 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006887/0.6211, allocations: 151.7 kB / 0.8908 GB, free: 12.56 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.127e-05/0.6212, allocations: 4 kB / 0.8908 GB, free: 12.55 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0008092/0.622, allocations: 107.2 kB / 0.8909 GB, free: 12.45 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.186e-05/0.622, allocations: 31.98 kB / 0.8909 GB, free: 12.42 MB / 0.6075 GB
Notification: Performance of prepare postOptimizeDAE: time 6.703e-06/0.6221, allocations: 4 kB / 0.8909 GB, free: 12.41 MB / 0.6075 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.001266/0.6233, allocations: 0.7767 MB / 0.8917 GB, free: 11.64 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.199e-06/0.6234, allocations: 2.062 kB / 0.8917 GB, free: 11.64 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (initialization): time 7.434e-06/0.6234, allocations: 8 kB / 0.8917 GB, free: 11.63 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0006565/0.624, allocations: 143.8 kB / 0.8918 GB, free: 11.49 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.157e-05/0.624, allocations: 11.94 kB / 0.8918 GB, free: 11.48 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.0007601/0.6248, allocations: 103.4 kB / 0.8919 GB, free: 11.38 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 5.9e-05/0.6249, allocations: 31.98 kB / 0.892 GB, free: 11.34 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 10
 * 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 (88):
 * Single equations (assignments): 88
 * 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.0004876/0.6254, allocations: 372.8 kB / 0.8923 GB, free: 10.97 MB / 0.6075 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001406/0.6255, allocations: 94.88 kB / 0.8924 GB, free: 10.88 MB / 0.6075 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.001366/0.6269, allocations: 0.807 MB / 0.8932 GB, free: 10.07 MB / 0.6075 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 8.045e-06/0.6269, allocations: 8 kB / 0.8932 GB, free: 10.06 MB / 0.6075 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 7.625e-06/0.6269, allocations: 7.891 kB / 0.8932 GB, free: 10.05 MB / 0.6075 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.001043/0.628, allocations: 0.7438 MB / 0.8939 GB, free: 9.277 MB / 0.6075 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003069/0.6311, allocations: 2.094 MB / 0.896 GB, free: 7.082 MB / 0.6075 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.732e-06/0.6311, allocations: 4 kB / 0.896 GB, free: 7.078 MB / 0.6075 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006492/0.6317, allocations: 131.8 kB / 0.8961 GB, free: 6.949 MB / 0.6075 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.751e-05/0.6318, allocations: 8 kB / 0.8961 GB, free: 6.941 MB / 0.6075 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.878e-05/0.6318, allocations: 16 kB / 0.8961 GB, free: 6.926 MB / 0.6075 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 9.438e-06/0.6318, allocations: 9.672 kB / 0.8961 GB, free: 6.918 MB / 0.6075 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.899e-06/0.6318, allocations: 4 kB / 0.8961 GB, free: 6.914 MB / 0.6075 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.001817/0.6337, allocations: 1.371 MB / 0.8975 GB, free: 5.484 MB / 0.6075 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0003872/0.6341, allocations: 255.9 kB / 0.8977 GB, free: 5.215 MB / 0.6075 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001237/0.6342, allocations: 16 kB / 0.8977 GB, free: 5.199 MB / 0.6075 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0005972/0.6348, allocations: 56.3 kB / 0.8978 GB, free: 5.145 MB / 0.6075 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 8.155e-05/0.6349, allocations: 44.34 kB / 0.8978 GB, free: 5.102 MB / 0.6075 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 4.653e-05/0.6349, allocations: 24 kB / 0.8979 GB, free: 5.078 MB / 0.6075 GB
Notification: Performance of sorting global known variables: time 0.0006899/0.6356, allocations: 0.5498 MB / 0.8984 GB, free: 4.531 MB / 0.6075 GB
Notification: Performance of sort global known variables: time 1.5e-07/0.6356, allocations: 0 / 0.8984 GB, free: 4.531 MB / 0.6075 GB
Notification: Performance of remove unused functions: time 0.001657/0.6373, allocations: 0.7528 MB / 0.8991 GB, free: 3.777 MB / 0.6075 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 15
 * Number of states: 3 (vol1.dynBal.medium.Xi[1],vol1.dynBal.U,vol1.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 (64):
 * Single equations (assignments): 64
 * 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 Backend phase and start with SimCode phase: time 0.001136/0.6385, allocations: 0.5307 MB / 0.8997 GB, free: 3.246 MB / 0.6075 GB
Notification: Performance of simCode: created initialization part: time 0.001869/0.6403, allocations: 1.163 MB / 0.9008 GB, free: 2.086 MB / 0.6075 GB
Notification: Performance of simCode: created event and clocks part: time 4.388e-06/0.6403, allocations: 0 / 0.9008 GB, free: 2.086 MB / 0.6075 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005237/0.6409, allocations: 378.2 kB / 0.9011 GB, free: 1.711 MB / 0.6075 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002264/0.6432, allocations: 0.5092 MB / 0.9016 GB, free: 1.211 MB / 0.6075 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.002955/0.6461, allocations: 2.283 MB / 0.9039 GB, free: 14.85 MB / 0.6231 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006485/0.6468, allocations: 1.078 MB / 0.9049 GB, free: 13.75 MB / 0.6231 GB
Notification: Performance of simCode: alias equations: time 0.001333/0.6481, allocations: 425.1 kB / 0.9053 GB, free: 13.33 MB / 0.6231 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002235/0.6484, allocations: 71.44 kB / 0.9054 GB, free: 13.26 MB / 0.6231 GB
Notification: Performance of SimCode: time 4.11e-07/0.6484, allocations: 0 / 0.9054 GB, free: 13.26 MB / 0.6231 GB
Notification: Performance of Templates: time 0.03295/0.6813, allocations: 21.42 MB / 0.9263 GB, free: 8.09 MB / 0.6387 GB
make -j1 -f BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.makefile
(rm -f BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; mkfifo BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; head -c 1048576 < BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe >> ../files/BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.sim & ./BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization  -abortSlowSimulation -alarm=480 -lv LOG_STATS > BuildingSystems_BuildingSystems.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe 2>&1)