Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.1-maint.8.1.x/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo)
Using package Complex with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo)
Using package Buildings with version 8.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.1-maint.8.1.x/package.mo)
Running command: translateModel(Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic")
translateModel(Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 8.1.1-maint.8.1.x/package.mo): time 1.676/1.676, allocations: 293 MB / 309 MB, free: 4.84 MB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.3+maint.om/package.mo): time 0.001064/0.001063, allocations: 166.7 kB / 378.7 MB, free: 1.008 MB / 298.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.497/1.497, allocations: 205.4 MB / 0.6383 GB, free: 8.113 MB / 474.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.3+maint.om/package.mo): time 0.0008453/0.0008454, allocations: 94.92 kB / 0.7527 GB, free: 62.9 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.0003639/0.0003639, allocations: 27.98 kB / 0.8768 GB, free: 10.41 MB / 0.6042 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2275/0.2279, allocations: 116.4 MB / 0.9904 GB, free: 5.859 MB / 0.7136 GB
Notification: Performance of FrontEnd - scodeFlatten: time 4.985/5.213, allocations: 2.119 GB / 3.109 GB, free: 93.61 MB / 0.948 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003367/5.213, allocations: 101.3 kB / 3.109 GB, free: 93.51 MB / 0.948 GB
Notification: Performance of FrontEnd - DAE generated: time 16.82/22.03, allocations: 4.373 GB / 7.482 GB, free: 13.69 MB / 1.104 GB
Notification: Performance of FrontEnd: time 2.785e-06/22.03, allocations: 3.938 kB / 7.482 GB, free: 13.69 MB / 1.104 GB
Notification: Performance of Transformations before backend: time 0.001327/22.03, allocations: 167.8 kB / 7.482 GB, free: 13.52 MB / 1.104 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 817
 * Number of variables: 817
Notification: Performance of Generate backend data structure: time 0.03855/22.07, allocations: 10.88 MB / 7.493 GB, free: 2.543 MB / 1.104 GB
Notification: Performance of prepare preOptimizeDAE: time 5.553e-05/22.07, allocations: 12.02 kB / 7.493 GB, free: 2.531 MB / 1.104 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01448/22.08, allocations: 1.651 MB / 7.495 GB, free: 0.8711 MB / 1.104 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0368/22.12, allocations: 11.42 MB / 7.506 GB, free: 5.359 MB / 1.12 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005516/22.12, allocations: 286.8 kB / 7.506 GB, free: 5.078 MB / 1.12 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002408/22.12, allocations: 388.6 kB / 7.506 GB, free: 4.699 MB / 1.12 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01627/22.14, allocations: 4.395 MB / 7.511 GB, free: 160 kB / 1.12 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002672/22.14, allocations: 7.844 kB / 7.511 GB, free: 152 kB / 1.12 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001787/22.14, allocations: 136 kB / 7.511 GB, free: 16 kB / 1.12 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.9062/23.05, allocations: 111.5 kB / 7.511 GB, free: 78.84 MB / 1.12 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01083/23.06, allocations: 3.241 MB / 7.514 GB, free: 78.8 MB / 1.12 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.04555/23.1, allocations: 20.14 MB / 7.534 GB, free: 71.71 MB / 1.12 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.007354/23.11, allocations: 3.147 MB / 7.537 GB, free: 71.29 MB / 1.12 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002735/23.11, allocations: 1.399 MB / 7.538 GB, free: 71.27 MB / 1.12 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003751/23.12, allocations: 230.5 kB / 7.538 GB, free: 71.08 MB / 1.12 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.003084/23.12, allocations: 1.846 MB / 7.54 GB, free: 71 MB / 1.12 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004236/23.12, allocations: 363.6 kB / 7.541 GB, free: 71 MB / 1.12 GB
Notification: Performance of pre-optimization done (n=207): time 2.103e-05/23.12, allocations: 3.031 kB / 7.541 GB, free: 71 MB / 1.12 GB
Notification: Performance of matching and sorting (n=207): time 0.01113/23.13, allocations: 4.426 MB / 7.545 GB, free: 70.55 MB / 1.12 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.000125/23.13, allocations: 333 kB / 7.545 GB, free: 70.17 MB / 1.12 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01976/23.15, allocations: 7.16 MB / 7.552 GB, free: 69.77 MB / 1.12 GB
Notification: Performance of collectPreVariables (initialization): time 0.001279/23.15, allocations: 91.06 kB / 7.552 GB, free: 69.74 MB / 1.12 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005235/23.16, allocations: 2.836 MB / 7.555 GB, free: 69.27 MB / 1.12 GB
Notification: Performance of collectInitialBindings (initialization): time 0.001839/23.16, allocations: 0.7136 MB / 7.556 GB, free: 68.9 MB / 1.12 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0009528/23.16, allocations: 62.09 kB / 7.556 GB, free: 68.9 MB / 1.12 GB
Notification: Performance of setup shared object (initialization): time 0.0004356/23.16, allocations: 433.6 kB / 7.556 GB, free: 68.59 MB / 1.12 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003816/23.17, allocations: 1.34 MB / 7.558 GB, free: 68.59 MB / 1.12 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.004708/23.17, allocations: 2.664 MB / 7.56 GB, free: 67.05 MB / 1.12 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008184/23.18, allocations: 3.818 MB / 7.564 GB, free: 65.9 MB / 1.12 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 8.831e-05/23.18, allocations: 13.16 kB / 7.564 GB, free: 65.89 MB / 1.12 GB
Notification: Performance of matching and sorting (n=420) (initialization): time 0.01389/23.19, allocations: 4.547 MB / 7.568 GB, free: 65.43 MB / 1.12 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0008283/23.2, allocations: 1.01 MB / 7.569 GB, free: 64.23 MB / 1.12 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001277/23.2, allocations: 38.47 kB / 7.569 GB, free: 64.23 MB / 1.12 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001085/23.2, allocations: 277.2 kB / 7.57 GB, free: 64.21 MB / 1.12 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004126/23.2, allocations: 0.7397 MB / 7.57 GB, free: 64.21 MB / 1.12 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.003341/23.2, allocations: 3.466 MB / 7.574 GB, free: 61.41 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008556/23.21, allocations: 348.1 kB / 7.574 GB, free: 61.4 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001298/23.21, allocations: 272.3 kB / 7.574 GB, free: 61.4 MB / 1.12 GB
Notification: Performance of prepare postOptimizeDAE: time 1.689e-05/23.21, allocations: 2.875 kB / 7.574 GB, free: 61.4 MB / 1.12 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.0117/23.23, allocations: 4.351 MB / 7.579 GB, free: 61.27 MB / 1.12 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000188/23.23, allocations: 39.44 kB / 7.579 GB, free: 61.27 MB / 1.12 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001318/23.23, allocations: 0.5456 MB / 7.579 GB, free: 61.25 MB / 1.12 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003227/23.23, allocations: 0.7172 MB / 7.58 GB, free: 61.25 MB / 1.12 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01018/23.24, allocations: 7.245 MB / 7.587 GB, free: 58.05 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007275/23.25, allocations: 340.3 kB / 7.587 GB, free: 58.04 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001237/23.25, allocations: 239.7 kB / 7.587 GB, free: 58.04 MB / 1.12 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 133
 * Number of states: 0 ()
 * Number of discrete variables: 5 ($whenCondition1,$PRE.y.T_start,y.T_start,$PRE.y.count,y.count)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (359):
 * Single equations (assignments): 341
 * Array equations: 8
 * Algorithm blocks: 1
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 3
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 3 {1,1,1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 6,1 6}
Notification: Performance of prepare postOptimizeDAE: time 0.006564/23.26, allocations: 1.605 MB / 7.589 GB, free: 57.85 MB / 1.12 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00256/23.26, allocations: 0.555 MB / 7.59 GB, free: 57.54 MB / 1.12 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01047/23.27, allocations: 3.378 MB / 7.593 GB, free: 57.35 MB / 1.12 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 2.267e-05/23.27, allocations: 20.62 kB / 7.593 GB, free: 57.35 MB / 1.12 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 8.366e-06/23.27, allocations: 1.812 kB / 7.593 GB, free: 57.35 MB / 1.12 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.005829/23.27, allocations: 2.872 MB / 7.596 GB, free: 56.83 MB / 1.12 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 postOpt removeSimpleEquations (simulation): time 0.03344/23.31, allocations: 9.108 MB / 7.605 GB, free: 55.96 MB / 1.12 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.894e-05/23.31, allocations: 8.891 kB / 7.605 GB, free: 55.96 MB / 1.12 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.003314/23.31, allocations: 0.5353 MB / 7.605 GB, free: 55.96 MB / 1.12 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0007704/23.31, allocations: 239.3 kB / 7.605 GB, free: 55.94 MB / 1.12 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0005906/23.31, allocations: 70.34 kB / 7.605 GB, free: 55.94 MB / 1.12 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002118/23.32, allocations: 3.293 MB / 7.609 GB, free: 53.14 MB / 1.12 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 7.544e-06/23.32, allocations: 5.75 kB / 7.609 GB, free: 53.14 MB / 1.12 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01177/23.33, allocations: 4.846 MB / 7.613 GB, free: 52.48 MB / 1.12 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.005021/23.33, allocations: 1.211 MB / 7.615 GB, free: 52.07 MB / 1.12 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.00288/23.33, allocations: 56.45 kB / 7.615 GB, free: 52.07 MB / 1.12 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006383/23.34, allocations: 327.8 kB / 7.615 GB, free: 52.06 MB / 1.12 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0007607/23.34, allocations: 140.8 kB / 7.615 GB, free: 52.05 MB / 1.12 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0006323/23.34, allocations: 108.5 kB / 7.615 GB, free: 52.05 MB / 1.12 GB
Notification: Performance of sorting global known variables: time 0.01654/23.36, allocations: 4.914 MB / 7.62 GB, free: 51.84 MB / 1.12 GB
Notification: Performance of sort global known variables: time 7.21e-07/23.36, allocations: 1.25 kB / 7.62 GB, free: 51.84 MB / 1.12 GB
Notification: Performance of remove unused functions: time 0.02324/23.38, allocations: 3.614 MB / 7.623 GB, free: 51.7 MB / 1.12 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 9
 * Number of states: 20 (fan1.vol.dynBal.U,fan1.vol.dynBal.m,fan1.vol.dynBal.mXi[1],fan1.filter.x[1],fan1.filter.x[2],fan3.vol.dynBal.U,fan3.vol.dynBal.m,fan3.vol.dynBal.mXi[1],fan3.filter.x[1],fan3.filter.x[2],fan2.vol.dynBal.U,fan2.vol.dynBal.m,fan2.vol.dynBal.mXi[1],fan2.filter.x[1],fan2.filter.x[2],fan4.vol.dynBal.U,fan4.vol.dynBal.m,fan4.vol.dynBal.mXi[1],fan4.filter.x[1],fan4.filter.x[2])
 * Number of discrete variables: 3 ($whenCondition1,y.T_start,y.count)
 * Number of discrete states: 1 (y.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (203):
 * Single equations (assignments): 196
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 2
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 3
 * Torn equation systems: 2
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 3 {1,1,1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 2 {1 6,1 6}
Notification: Performance of Backend phase and start with SimCode phase: time 0.02511/23.41, allocations: 11.05 MB / 7.634 GB, free: 45.85 MB / 1.12 GB
Notification: Performance of simCode: created initialization part: time 0.01602/23.42, allocations: 6.166 MB / 7.64 GB, free: 45.18 MB / 1.12 GB
Notification: Performance of simCode: created event and clocks part: time 1.54e-05/23.42, allocations: 6.672 kB / 7.64 GB, free: 45.18 MB / 1.12 GB
Notification: Performance of simCode: created simulation system equations: time 0.003815/23.43, allocations: 1.392 MB / 7.642 GB, free: 45.16 MB / 1.12 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.02671/23.45, allocations: 3.239 MB / 7.645 GB, free: 45.07 MB / 1.12 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.03018/23.48, allocations: 12.64 MB / 7.657 GB, free: 40.11 MB / 1.12 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.007662/23.49, allocations: 3.492 MB / 7.661 GB, free: 39.27 MB / 1.12 GB
Notification: Performance of simCode: alias equations: time 0.01265/23.51, allocations: 1.672 MB / 7.662 GB, free: 39.22 MB / 1.12 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.003433/23.51, allocations: 476.6 kB / 7.663 GB, free: 39.21 MB / 1.12 GB
Notification: Performance of SimCode: time 2.394e-06/23.51, allocations: 3.75 kB / 7.663 GB, free: 39.21 MB / 1.12 GB
Notification: Performance of Templates: time 0.3379/23.85, allocations: 208 MB / 7.866 GB, free: 6.121 MB / 1.12 GB
make -j1 -f Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.makefile
(rm -f Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe ; mkfifo Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe ; head -c 1048576 < Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe >> ../files/Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.sim & ./Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_8_Buildings.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe 2>&1)