Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/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/ModelicaServices 4.0.0+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/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 Buildings with version 10.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/package.mo)
Running command: translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization")
translateModel(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.0.0-master/package.mo): time 2.148/2.148, allocations: 391.2 MB / 407 MB, free: 10.88 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.00119/0.001189, allocations: 190.3 kB / 499.1 MB, free: 4.676 MB / 394.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.528/1.528, allocations: 222.9 MB / 0.7948 GB, free: 15.8 MB / 0.5573 GB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001123/0.001123, allocations: 107.7 kB / 0.9329 GB, free: 7.105 MB / 0.6823 GB
Notification: Performance of FrontEnd - loaded program: time 0.001062/0.001063, allocations: 50.17 kB / 1.081 GB, free: 218.1 MB / 0.823 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3201/0.3212, allocations: 140.6 MB / 1.218 GB, free: 117.3 MB / 0.823 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization): time 0.1875/0.5087, allocations: 186.2 MB / 1.4 GB, free: 10.41 MB / 0.9011 GB
Notification: Performance of NFInst.instExpressions: time 0.01665/0.5254, allocations: 11.2 MB / 1.411 GB, free: 15.18 MB / 0.9167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002096/0.5275, allocations: 43.69 kB / 1.411 GB, free: 15.13 MB / 0.9167 GB
Notification: Performance of NFTyping.typeComponents: time 0.001815/0.5294, allocations: 441.7 kB / 1.411 GB, free: 14.7 MB / 0.9167 GB
Notification: Performance of NFTyping.typeBindings: time 0.007754/0.5372, allocations: 2.421 MB / 1.414 GB, free: 12.27 MB / 0.9167 GB
Notification: Performance of NFTyping.typeClassSections: time 0.007053/0.5443, allocations: 2.074 MB / 1.416 GB, free: 10.2 MB / 0.9167 GB
Notification: Performance of NFFlatten.flatten: time 0.005468/0.5497, allocations: 3.995 MB / 1.42 GB, free: 6.195 MB / 0.9167 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.001625/0.5514, allocations: 0.6585 MB / 1.42 GB, free: 5.523 MB / 0.9167 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.002292/0.5537, allocations: 0.8636 MB / 1.421 GB, free: 4.656 MB / 0.9167 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.002796/0.5565, allocations: 1.064 MB / 1.422 GB, free: 3.59 MB / 0.9167 GB
Notification: Performance of NFPackage.collectConstants: time 0.0003852/0.5569, allocations: 48 kB / 1.422 GB, free: 3.543 MB / 0.9167 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.006931/0.5639, allocations: 3.301 MB / 1.425 GB, free: 240 kB / 0.9167 GB
Notification: Performance of NFScalarize.scalarize: time 0.6778/1.242, allocations: 388.3 kB / 1.426 GB, free: 7.492 MB / 0.9167 GB
Notification: Performance of NFVerifyModel.verify: time 0.001371/1.243, allocations: 0.5274 MB / 1.426 GB, free: 7.492 MB / 0.9167 GB
Notification: Performance of NFConvertDAE.convert: time 0.009173/1.252, allocations: 3.034 MB / 1.429 GB, free: 7.426 MB / 0.9167 GB
Notification: Performance of FrontEnd - DAE generated: time 6.823e-06/1.252, allocations: 0.5625 kB / 1.429 GB, free: 7.426 MB / 0.9167 GB
Notification: Performance of FrontEnd: time 1.302e-06/1.252, allocations: 0 / 1.429 GB, free: 7.426 MB / 0.9167 GB
Notification: Performance of Transformations before backend: time 3.806e-05/1.252, allocations: 0 / 1.429 GB, free: 7.426 MB / 0.9167 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.005535/1.258, allocations: 1.673 MB / 1.431 GB, free: 6.609 MB / 0.9167 GB
Notification: Performance of prepare preOptimizeDAE: time 5.219e-05/1.258, allocations: 14.48 kB / 1.431 GB, free: 6.605 MB / 0.9167 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.002097/1.26, allocations: 294.5 kB / 1.431 GB, free: 6.547 MB / 0.9167 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.001665/1.262, allocations: 0.7744 MB / 1.432 GB, free: 6.234 MB / 0.9167 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 5.983e-05/1.262, allocations: 52.94 kB / 1.432 GB, free: 6.234 MB / 0.9167 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0001341/1.262, allocations: 77.73 kB / 1.432 GB, free: 6.23 MB / 0.9167 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.001968/1.264, allocations: 0.9919 MB / 1.433 GB, free: 6.148 MB / 0.9167 GB
Notification: Performance of preOpt findStateOrder (simulation): time 2.29e-05/1.264, allocations: 1.281 kB / 1.433 GB, free: 6.148 MB / 0.9167 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 8.422e-05/1.264, allocations: 24.3 kB / 1.433 GB, free: 6.148 MB / 0.9167 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001273/1.264, allocations: 74.95 kB / 1.433 GB, free: 6.148 MB / 0.9167 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.001949/1.266, allocations: 1.009 MB / 1.434 GB, free: 6.137 MB / 0.9167 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.007576/1.274, allocations: 3.571 MB / 1.438 GB, free: 20.82 MB / 0.9323 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001271/1.275, allocations: 0.6609 MB / 1.438 GB, free: 20.79 MB / 0.9323 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0005949/1.276, allocations: 376 kB / 1.439 GB, free: 20.79 MB / 0.9323 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002966/1.276, allocations: 200.1 kB / 1.439 GB, free: 20.59 MB / 0.9323 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 4.749e-05/1.276, allocations: 44.67 kB / 1.439 GB, free: 20.55 MB / 0.9323 GB
Notification: Performance of pre-optimization done (n=62): time 3.165e-06/1.276, allocations: 1.203 kB / 1.439 GB, free: 20.55 MB / 0.9323 GB
Notification: Performance of matching and sorting (n=62): time 0.002271/1.278, allocations: 1.02 MB / 1.44 GB, free: 20.46 MB / 0.9323 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.049e-05/1.278, allocations: 110.6 kB / 1.44 GB, free: 20.33 MB / 0.9323 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.001285/1.28, allocations: 0.8057 MB / 1.441 GB, free: 20.2 MB / 0.9323 GB
Notification: Performance of collectPreVariables (initialization): time 8.25e-05/1.28, allocations: 41.3 kB / 1.441 GB, free: 20.16 MB / 0.9323 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0003302/1.28, allocations: 426.4 kB / 1.441 GB, free: 19.99 MB / 0.9323 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002229/1.28, allocations: 217.6 kB / 1.441 GB, free: 19.85 MB / 0.9323 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0002883/1.281, allocations: 145.5 kB / 1.442 GB, free: 19.83 MB / 0.9323 GB
Notification: Performance of setup shared object (initialization): time 0.0001427/1.281, allocations: 333.6 kB / 1.442 GB, free: 19.52 MB / 0.9323 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.0005959/1.281, allocations: 339.9 kB / 1.442 GB, free: 19.52 MB / 0.9323 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.000693/1.282, allocations: 467.7 kB / 1.443 GB, free: 19.41 MB / 0.9323 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.001227/1.283, allocations: 0.7724 MB / 1.443 GB, free: 19.32 MB / 0.9323 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 4.939e-06/1.283, allocations: 1.312 kB / 1.443 GB, free: 19.32 MB / 0.9323 GB
Notification: Performance of matching and sorting (n=88) (initialization): time 0.001654/1.285, allocations: 0.9351 MB / 1.444 GB, free: 19.23 MB / 0.9323 GB
Notification: Performance of prepare postOptimizeDAE: time 2.113e-05/1.285, allocations: 5.594 kB / 1.444 GB, free: 19.23 MB / 0.9323 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.219e-05/1.285, allocations: 3.422 kB / 1.444 GB, free: 19.23 MB / 0.9323 GB
Notification: Performance of postOpt tearingSystem (initialization): time 2.059e-05/1.285, allocations: 5.5 kB / 1.444 GB, free: 19.23 MB / 0.9323 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.000712/1.286, allocations: 149.6 kB / 1.444 GB, free: 19.23 MB / 0.9323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.658e-05/1.286, allocations: 9.641 kB / 1.444 GB, free: 19.23 MB / 0.9323 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001081/1.287, allocations: 107.5 kB / 1.445 GB, free: 19.18 MB / 0.9323 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 7.853e-05/1.287, allocations: 28.78 kB / 1.445 GB, free: 19.18 MB / 0.9323 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.0009473/1.288, allocations: 0.5396 MB / 1.445 GB, free: 19.1 MB / 0.9323 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.0006184/1.289, allocations: 450.5 kB / 1.446 GB, free: 18.98 MB / 0.9323 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.001058/1.29, allocations: 0.7397 MB / 1.446 GB, free: 18.87 MB / 0.9323 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.137e-06/1.29, allocations: 1.094 kB / 1.446 GB, free: 18.87 MB / 0.9323 GB
Notification: Performance of matching and sorting (n=88) (initialization_lambda0): time 0.001726/1.291, allocations: 0.8841 MB / 1.447 GB, free: 18.78 MB / 0.9323 GB
Notification: Performance of prepare postOptimizeDAE: time 1.996e-05/1.291, allocations: 9.219 kB / 1.447 GB, free: 18.77 MB / 0.9323 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.354e-06/1.291, allocations: 3.656 kB / 1.447 GB, free: 18.77 MB / 0.9323 GB
Notification: Performance of postOpt tearingSystem (initialization): time 1.308e-05/1.291, allocations: 12.95 kB / 1.447 GB, free: 18.77 MB / 0.9323 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0007374/1.292, allocations: 147.2 kB / 1.447 GB, free: 18.77 MB / 0.9323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 1.152e-05/1.292, allocations: 8.906 kB / 1.447 GB, free: 18.77 MB / 0.9323 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.001062/1.293, allocations: 97.17 kB / 1.447 GB, free: 18.74 MB / 0.9323 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 6.33e-05/1.293, allocations: 24.12 kB / 1.447 GB, free: 18.74 MB / 0.9323 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 (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.0003105/1.294, allocations: 220.4 kB / 1.448 GB, free: 18.56 MB / 0.9323 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0001765/1.294, allocations: 91.34 kB / 1.448 GB, free: 18.51 MB / 0.9323 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.00143/1.295, allocations: 0.8048 MB / 1.448 GB, free: 18.45 MB / 0.9323 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.895e-06/1.295, allocations: 13.34 kB / 1.448 GB, free: 18.45 MB / 0.9323 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 5.19e-06/1.295, allocations: 2.844 kB / 1.448 GB, free: 18.45 MB / 0.9323 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.0009042/1.296, allocations: 0.7433 MB / 1.449 GB, free: 18.28 MB / 0.9323 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.003758/1.3, allocations: 2.09 MB / 1.451 GB, free: 17.84 MB / 0.9323 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.106e-05/1.3, allocations: 3.812 kB / 1.451 GB, free: 17.84 MB / 0.9323 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0006992/1.301, allocations: 135.7 kB / 1.451 GB, free: 17.84 MB / 0.9323 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.456e-05/1.301, allocations: 13.06 kB / 1.451 GB, free: 17.83 MB / 0.9323 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 5.69e-05/1.301, allocations: 18.41 kB / 1.451 GB, free: 17.83 MB / 0.9323 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 1.283e-05/1.301, allocations: 6.5 kB / 1.451 GB, free: 17.83 MB / 0.9323 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 8.155e-06/1.301, allocations: 7.312 kB / 1.451 GB, free: 17.83 MB / 0.9323 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.2129/1.514, allocations: 14.85 MB / 1.466 GB, free: 15.45 MB / 0.9323 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.0008577/1.515, allocations: 260.6 kB / 1.466 GB, free: 15.3 MB / 0.9323 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0001564/1.515, allocations: 15.12 kB / 1.466 GB, free: 15.3 MB / 0.9323 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0007204/1.516, allocations: 52.97 kB / 1.466 GB, free: 15.29 MB / 0.9323 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001139/1.516, allocations: 47.94 kB / 1.466 GB, free: 15.28 MB / 0.9323 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 5.734e-05/1.516, allocations: 28.31 kB / 1.466 GB, free: 15.28 MB / 0.9323 GB
Notification: Performance of sorting global known variables: time 0.0008317/1.517, allocations: 0.5589 MB / 1.467 GB, free: 15.18 MB / 0.9323 GB
Notification: Performance of sort global known variables: time 1.6e-07/1.517, allocations: 1.094 kB / 1.467 GB, free: 15.18 MB / 0.9323 GB
Notification: Performance of remove unused functions: time 0.006203/1.523, allocations: 1.656 MB / 1.468 GB, free: 14.97 MB / 0.9323 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 (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.005458/1.528, allocations: 1.282 MB / 1.47 GB, free: 14.71 MB / 0.9323 GB
Notification: Performance of simCode: created initialization part: time 0.002165/1.531, allocations: 1.168 MB / 1.471 GB, free: 14.69 MB / 0.9323 GB
Notification: Performance of simCode: created event and clocks part: time 7.744e-06/1.531, allocations: 3.031 kB / 1.471 GB, free: 14.69 MB / 0.9323 GB
Notification: Performance of simCode: created simulation system equations: time 0.0005089/1.531, allocations: 375.8 kB / 1.471 GB, free: 14.69 MB / 0.9323 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.002747/1.534, allocations: 0.5196 MB / 1.472 GB, free: 14.65 MB / 0.9323 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.003283/1.537, allocations: 2.676 MB / 1.474 GB, free: 13.3 MB / 0.9323 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.0006383/1.538, allocations: 1.1 MB / 1.475 GB, free: 12.59 MB / 0.9323 GB
Notification: Performance of simCode: alias equations: time 0.001549/1.539, allocations: 447.2 kB / 1.476 GB, free: 12.53 MB / 0.9323 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0002885/1.54, allocations: 86.58 kB / 1.476 GB, free: 12.52 MB / 0.9323 GB
Notification: Performance of SimCode: time 5.01e-07/1.54, allocations: 0 / 1.476 GB, free: 12.52 MB / 0.9323 GB
Notification: Performance of Templates: time 0.1277/1.667, allocations: 88.78 MB / 1.563 GB, free: 12.36 MB / 0.9948 GB
make -j1 -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.makefile
(rm -f Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; mkfifo Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe >> ../files/Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.sim & ./Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_latest_Buildings.Fluid.MixingVolumes.Validation.MixingVolumeInitialization.pipe 2>&1)