Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine.conf.json
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/IBPSA 3.0.0-master/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 IBPSA with version 3.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/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)
Running command: translateModel(IBPSA.Fluid.Movers.Validation.ControlledFlowMachine,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine")
translateModel(IBPSA.Fluid.Movers.Validation.ControlledFlowMachine,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001276/0.001276, allocations: 172.8 kB / 16.76 MB, free: 4.934 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 3.0.0-master/package.mo): time 0.5031/0.5031, allocations: 86.27 MB / 103.8 MB, free: 14.57 MB / 90.72 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.256/1.256, allocations: 223.2 MB / 348.4 MB, free: 5.031 MB / 282.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008125/0.0008126, allocations: 94.42 kB / 420.2 MB, free: 9.68 MB / 314.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003641/0.0003642, allocations: 16 kB / 0.4901 GB, free: 8.035 MB / 394.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.284/0.2844, allocations: 71.02 MB / 0.5594 GB, free: 43.75 MB / 410.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 3.297/3.581, allocations: 1.902 GB / 2.461 GB, free: 153 MB / 0.6042 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.000273/3.582, allocations: 100.9 kB / 2.461 GB, free: 152.9 MB / 0.6042 GB
Notification: Performance of FrontEnd - DAE generated: time 14.74/18.33, allocations: 4.371 GB / 6.833 GB, free: 58.11 MB / 0.7761 GB
Notification: Performance of FrontEnd: time 1.573e-06/18.33, allocations: 3.5 kB / 6.833 GB, free: 58.11 MB / 0.7761 GB
Notification: Performance of Transformations before backend: time 0.0008991/18.33, allocations: 142.6 kB / 6.833 GB, free: 58.09 MB / 0.7761 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 743
 * Number of variables: 743
Notification: Performance of Generate backend data structure: time 0.0303/18.36, allocations: 10.45 MB / 6.843 GB, free: 54.85 MB / 0.7761 GB
Notification: Performance of prepare preOptimizeDAE: time 4.21e-05/18.36, allocations: 10.03 kB / 6.843 GB, free: 54.85 MB / 0.7761 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01036/18.37, allocations: 1.432 MB / 6.845 GB, free: 54.49 MB / 0.7761 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02266/18.39, allocations: 11 MB / 6.855 GB, free: 53.14 MB / 0.7761 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002916/18.39, allocations: 259 kB / 6.856 GB, free: 53.13 MB / 0.7761 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0009446/18.39, allocations: 353 kB / 6.856 GB, free: 53.12 MB / 0.7761 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.00925/18.4, allocations: 3.954 MB / 6.86 GB, free: 52.77 MB / 0.7761 GB
Notification: Performance of preOpt findStateOrder (simulation): time 8.539e-05/18.4, allocations: 1.406 kB / 6.86 GB, free: 52.77 MB / 0.7761 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0004371/18.4, allocations: 122.4 kB / 6.86 GB, free: 52.77 MB / 0.7761 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001121/18.4, allocations: 107.5 kB / 6.86 GB, free: 52.76 MB / 0.7761 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005298/18.41, allocations: 2.951 MB / 6.863 GB, free: 52.72 MB / 0.7761 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.02643/18.43, allocations: 19.33 MB / 6.882 GB, free: 44.79 MB / 0.7761 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.004113/18.44, allocations: 2.705 MB / 6.884 GB, free: 44.36 MB / 0.7761 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.001761/18.44, allocations: 1.249 MB / 6.886 GB, free: 44.33 MB / 0.7761 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0003008/18.44, allocations: 230.8 kB / 6.886 GB, free: 44.14 MB / 0.7761 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002152/18.44, allocations: 1.671 MB / 6.887 GB, free: 44.07 MB / 0.7761 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.003072/18.44, allocations: 401.2 kB / 6.888 GB, free: 43.96 MB / 0.7761 GB
Notification: Performance of pre-optimization done (n=180): time 6.743e-06/18.44, allocations: 0 / 6.888 GB, free: 43.96 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=180): time 0.00783/18.45, allocations: 3.962 MB / 6.892 GB, free: 43.36 MB / 0.7761 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.416e-05/18.45, allocations: 71.16 kB / 6.892 GB, free: 43.3 MB / 0.7761 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01094/18.46, allocations: 6.899 MB / 6.899 GB, free: 42.89 MB / 0.7761 GB
Notification: Performance of collectPreVariables (initialization): time 0.0008655/18.46, allocations: 84.94 kB / 6.899 GB, free: 42.86 MB / 0.7761 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002271/18.47, allocations: 2.645 MB / 6.901 GB, free: 42.26 MB / 0.7761 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0008678/18.47, allocations: 0.6243 MB / 6.902 GB, free: 41.86 MB / 0.7761 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0001695/18.47, allocations: 54.59 kB / 6.902 GB, free: 41.86 MB / 0.7761 GB
Notification: Performance of setup shared object (initialization): time 0.0001431/18.47, allocations: 420 kB / 6.902 GB, free: 41.55 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001797/18.47, allocations: 1.147 MB / 6.903 GB, free: 41.54 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.002182/18.47, allocations: 2.405 MB / 6.906 GB, free: 40.05 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.003821/18.48, allocations: 3.475 MB / 6.909 GB, free: 38.89 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.677e-05/18.48, allocations: 9.938 kB / 6.909 GB, free: 38.89 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=375) (initialization): time 0.006905/18.48, allocations: 4.051 MB / 6.913 GB, free: 38.47 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 0.000463/18.48, allocations: 1.029 MB / 6.914 GB, free: 37.26 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 3.243e-05/18.48, allocations: 27.81 kB / 6.914 GB, free: 37.26 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.000826/18.48, allocations: 287.5 kB / 6.914 GB, free: 37.24 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002739/18.49, allocations: 0.6505 MB / 6.915 GB, free: 37.24 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002085/18.49, allocations: 3.468 MB / 6.918 GB, free: 34.44 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005075/18.49, allocations: 328.9 kB / 6.919 GB, free: 34.41 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0004169/18.49, allocations: 256.1 kB / 6.919 GB, free: 34.41 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 9.508e-06/18.49, allocations: 2.562 kB / 6.919 GB, free: 34.41 MB / 0.7761 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.005855/18.5, allocations: 3.987 MB / 6.923 GB, free: 34.31 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.784e-05/18.5, allocations: 30.38 kB / 6.923 GB, free: 34.31 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.001078/18.5, allocations: 0.5459 MB / 6.923 GB, free: 34.29 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002235/18.5, allocations: 0.6554 MB / 6.924 GB, free: 34.29 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.008493/18.51, allocations: 7.268 MB / 6.931 GB, free: 31.08 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005402/18.52, allocations: 335.5 kB / 6.931 GB, free: 31.06 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005248/18.52, allocations: 224.2 kB / 6.932 GB, free: 31.05 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 137
 * 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 (322):
 * Single equations (assignments): 312
 * Array equations: 4
 * Algorithm blocks: 1
 * Record equations: 0
 * 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.003581/18.52, allocations: 1.532 MB / 6.933 GB, free: 30.85 MB / 0.7761 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001352/18.52, allocations: 0.5224 MB / 6.934 GB, free: 30.56 MB / 0.7761 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.005366/18.53, allocations: 3.013 MB / 6.937 GB, free: 30.38 MB / 0.7761 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.351e-05/18.53, allocations: 15 kB / 6.937 GB, free: 30.38 MB / 0.7761 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.569e-06/18.53, allocations: 2.062 kB / 6.937 GB, free: 30.38 MB / 0.7761 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.003368/18.53, allocations: 2.571 MB / 6.939 GB, free: 29.85 MB / 0.7761 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.01455/18.55, allocations: 8.408 MB / 6.947 GB, free: 28.43 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.955e-06/18.55, allocations: 5.531 kB / 6.947 GB, free: 28.43 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002079/18.55, allocations: 493.9 kB / 6.948 GB, free: 28.41 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0005205/18.55, allocations: 233.4 kB / 6.948 GB, free: 28.34 MB / 0.7761 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.000139/18.55, allocations: 56.27 kB / 6.948 GB, free: 28.32 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.001448/18.55, allocations: 3.293 MB / 6.951 GB, free: 25.31 MB / 0.7761 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.41e-06/18.55, allocations: 8.531 kB / 6.951 GB, free: 25.3 MB / 0.7761 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.006551/18.56, allocations: 4.306 MB / 6.956 GB, free: 23.41 MB / 0.7761 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.003336/18.56, allocations: 1.146 MB / 6.957 GB, free: 22.7 MB / 0.7761 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001107/18.56, allocations: 46.19 kB / 6.957 GB, free: 22.67 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.003024/18.56, allocations: 310.2 kB / 6.957 GB, free: 22.63 MB / 0.7761 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002372/18.57, allocations: 123 kB / 6.957 GB, free: 22.61 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0001525/18.57, allocations: 90.5 kB / 6.957 GB, free: 22.59 MB / 0.7761 GB
Notification: Performance of sorting global known variables: time 0.007283/18.57, allocations: 4.758 MB / 6.962 GB, free: 20.72 MB / 0.7761 GB
Notification: Performance of sort global known variables: time 3.91e-07/18.57, allocations: 0 / 6.962 GB, free: 20.72 MB / 0.7761 GB
Notification: Performance of remove unused functions: time 0.01144/18.58, allocations: 3.423 MB / 6.965 GB, free: 19.88 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 9
 * Number of states: 14 (fan1.vol.dynBal.U,fan1.vol.dynBal.m,fan1.vol.dynBal.mXi[1],fan1.filter.s[1],fan1.filter.s[2],fan3.vol.dynBal.U,fan3.vol.dynBal.m,fan3.vol.dynBal.mXi[1],fan2.vol.dynBal.U,fan2.vol.dynBal.m,fan2.vol.dynBal.mXi[1],fan4.vol.dynBal.U,fan4.vol.dynBal.m,fan4.vol.dynBal.mXi[1])
 * 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 (176):
 * Single equations (assignments): 169
 * 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.01298/18.6, allocations: 10.99 MB / 6.976 GB, free: 13.7 MB / 0.7761 GB
Notification: Performance of simCode: created initialization part: time 0.009103/18.61, allocations: 5.36 MB / 6.981 GB, free: 11.86 MB / 0.7761 GB
Notification: Performance of simCode: created event and clocks part: time 6.422e-06/18.61, allocations: 0 / 6.981 GB, free: 11.86 MB / 0.7761 GB
Notification: Performance of simCode: created simulation system equations: time 0.001948/18.61, allocations: 1.215 MB / 6.982 GB, free: 11.49 MB / 0.7761 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01526/18.62, allocations: 3.105 MB / 6.985 GB, free: 10.84 MB / 0.7761 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01571/18.64, allocations: 11.65 MB / 6.997 GB, free: 4.539 MB / 0.7761 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.002835/18.64, allocations: 3.301 MB / 7 GB, free: 2.016 MB / 0.7761 GB
Notification: Performance of simCode: alias equations: time 0.007223/18.65, allocations: 1.567 MB / 7.002 GB, free: 0.9492 MB / 0.7761 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001433/18.65, allocations: 438.2 kB / 7.002 GB, free: 0.5625 MB / 0.7761 GB
Notification: Performance of SimCode: time 6.32e-07/18.65, allocations: 0 / 7.002 GB, free: 0.5625 MB / 0.7761 GB
Notification: Performance of Templates: time 0.7714/19.42, allocations: 202.2 MB / 7.199 GB, free: 57.13 MB / 0.7917 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine.sim & ./IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachine.pipe 2>&1)