Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic.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/IBPSA 4.0.0-master/package.mo", uses=false)
Using package IBPSA with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-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(IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic")
translateModel(IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.000991/0.0009911, allocations: 116.4 kB / 17.09 MB, free: 5.988 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.001017/0.001017, allocations: 197.5 kB / 18.03 MB, free: 5.062 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.218/1.218, allocations: 222.9 MB / 241.7 MB, free: 15.09 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IBPSA 4.0.0-master/package.mo): time 0.6573/0.6573, allocations: 115.3 MB / 407.2 MB, free: 6.16 MB / 318.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001127/0.001127, allocations: 67.42 kB / 0.5584 GB, free: 32.22 MB / 446.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1133/0.1145, allocations: 76.18 MB / 0.6328 GB, free: 4.371 MB / 478.1 MB
Notification: Performance of NFInst.instantiate(IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic): time 0.5615/0.676, allocations: 321.5 MB / 0.9467 GB, free: 10.58 MB / 0.7012 GB
Notification: Performance of NFInst.instExpressions: time 0.0461/0.7222, allocations: 39.55 MB / 0.9853 GB, free: 2.93 MB / 0.7325 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.004534/0.7267, allocations: 155.2 kB / 0.9855 GB, free: 2.777 MB / 0.7325 GB
Notification: Performance of NFTyping.typeComponents: time 0.008345/0.7351, allocations: 3.396 MB / 0.9888 GB, free: 15.37 MB / 0.7481 GB
Notification: Performance of NFTyping.typeBindings: time 0.0175/0.7526, allocations: 7.309 MB / 0.9959 GB, free: 8.031 MB / 0.7481 GB
Notification: Performance of NFTyping.typeClassSections: time 0.008276/0.7609, allocations: 3.769 MB / 0.9996 GB, free: 4.273 MB / 0.7481 GB
Notification: Performance of NFFlatten.flatten: time 0.04747/0.8084, allocations: 36.62 MB / 1.035 GB, free: 15.6 MB / 0.795 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.006128/0.8145, allocations: 3.729 MB / 1.039 GB, free: 11.8 MB / 0.795 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01174/0.8263, allocations: 6.053 MB / 1.045 GB, free: 5.727 MB / 0.795 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.00623/0.8325, allocations: 3.666 MB / 1.048 GB, free: 2.055 MB / 0.795 GB
Notification: Performance of NFPackage.collectConstants: time 0.001478/0.834, allocations: 0.5195 MB / 1.049 GB, free: 1.535 MB / 0.795 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.3653/1.199, allocations: 5.695 MB / 1.055 GB, free: 43.33 MB / 0.795 GB
Notification: Performance of NFScalarize.scalarize: time 0.003166/1.203, allocations: 2.567 MB / 1.057 GB, free: 43.33 MB / 0.795 GB
Notification: Performance of NFVerifyModel.verify: time 0.005107/1.208, allocations: 3.491 MB / 1.06 GB, free: 43.33 MB / 0.795 GB
Notification: Performance of NFConvertDAE.convert: time 0.01391/1.222, allocations: 11.21 MB / 1.071 GB, free: 42.38 MB / 0.795 GB
Notification: Performance of FrontEnd - DAE generated: time 4.588e-06/1.222, allocations: 0 / 1.071 GB, free: 42.38 MB / 0.795 GB
Notification: Performance of FrontEnd: time 1.673e-06/1.222, allocations: 1.031 kB / 1.071 GB, free: 42.38 MB / 0.795 GB
Notification: Performance of Transformations before backend: time 0.0001686/1.222, allocations: 0 / 1.071 GB, free: 42.38 MB / 0.795 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 623
 * Number of variables: 623
Notification: Performance of Generate backend data structure: time 0.015/1.237, allocations: 7.419 MB / 1.079 GB, free: 39.02 MB / 0.795 GB
Notification: Performance of prepare preOptimizeDAE: time 4.294e-05/1.237, allocations: 8.406 kB / 1.079 GB, free: 39.02 MB / 0.795 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01172/1.249, allocations: 2.008 MB / 1.081 GB, free: 38.66 MB / 0.795 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01347/1.262, allocations: 8.693 MB / 1.089 GB, free: 37.53 MB / 0.795 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000132/1.262, allocations: 215.1 kB / 1.089 GB, free: 37.52 MB / 0.795 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0004736/1.263, allocations: 282.6 kB / 1.09 GB, free: 37.52 MB / 0.795 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.005822/1.269, allocations: 3.847 MB / 1.093 GB, free: 37.21 MB / 0.795 GB
Notification: Performance of preOpt findStateOrder (simulation): time 4.89e-05/1.269, allocations: 4.25 kB / 1.093 GB, free: 37.21 MB / 0.795 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002684/1.269, allocations: 106.6 kB / 1.093 GB, free: 37.21 MB / 0.795 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 6.553e-05/1.269, allocations: 94.27 kB / 1.094 GB, free: 37.2 MB / 0.795 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.005386/1.274, allocations: 2.92 MB / 1.096 GB, free: 37.17 MB / 0.795 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.01844/1.293, allocations: 15.99 MB / 1.112 GB, free: 30.93 MB / 0.795 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.005246/1.298, allocations: 2.462 MB / 1.114 GB, free: 30.88 MB / 0.795 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.002423/1.3, allocations: 1.381 MB / 1.116 GB, free: 30.87 MB / 0.795 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002734/1.301, allocations: 224.5 kB / 1.116 GB, free: 30.68 MB / 0.795 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.002788/1.304, allocations: 1.888 MB / 1.118 GB, free: 30.61 MB / 0.795 GB
Notification: Performance of pre-optimization done (n=157): time 4.218e-06/1.304, allocations: 1 kB / 1.118 GB, free: 30.61 MB / 0.795 GB
Notification: Performance of matching and sorting (n=157): time 0.009107/1.313, allocations: 3.971 MB / 1.122 GB, free: 30.15 MB / 0.795 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 2.893e-05/1.313, allocations: 71.12 kB / 1.122 GB, free: 30.09 MB / 0.795 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009377/1.322, allocations: 6.63 MB / 1.128 GB, free: 29.63 MB / 0.795 GB
Notification: Performance of collectPreVariables (initialization): time 0.0006346/1.323, allocations: 70.36 kB / 1.128 GB, free: 29.6 MB / 0.795 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002/1.325, allocations: 2.473 MB / 1.131 GB, free: 29.07 MB / 0.795 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0007184/1.326, allocations: 0.5622 MB / 1.131 GB, free: 28.71 MB / 0.795 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001126/1.327, allocations: 0.8454 MB / 1.132 GB, free: 28.66 MB / 0.795 GB
Notification: Performance of setup shared object (initialization): time 3.59e-05/1.327, allocations: 302.1 kB / 1.132 GB, free: 28.36 MB / 0.795 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.003419/1.33, allocations: 2.686 MB / 1.135 GB, free: 28.33 MB / 0.795 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003852/1.334, allocations: 3.715 MB / 1.139 GB, free: 27.32 MB / 0.795 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.006527/1.341, allocations: 6.037 MB / 1.145 GB, free: 26.45 MB / 0.795 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 1.483e-05/1.341, allocations: 10.31 kB / 1.145 GB, free: 26.44 MB / 0.795 GB
Notification: Performance of matching and sorting (n=499) (initialization): time 0.009813/1.35, allocations: 7.178 MB / 1.152 GB, free: 25.15 MB / 0.795 GB
Notification: Performance of prepare postOptimizeDAE: time 4.17e-05/1.35, allocations: 47.36 kB / 1.152 GB, free: 25.11 MB / 0.795 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.575e-05/1.35, allocations: 20 kB / 1.152 GB, free: 25.09 MB / 0.795 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0006588/1.351, allocations: 417.6 kB / 1.152 GB, free: 24.86 MB / 0.795 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.003598/1.355, allocations: 0.7833 MB / 1.153 GB, free: 24.27 MB / 0.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002143/1.357, allocations: 3.251 MB / 1.156 GB, free: 21.48 MB / 0.795 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004756/1.362, allocations: 457.2 kB / 1.156 GB, free: 21.09 MB / 0.795 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0002957/1.362, allocations: 187.8 kB / 1.157 GB, free: 20.92 MB / 0.795 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.00469/1.367, allocations: 3.696 MB / 1.16 GB, free: 17.35 MB / 0.795 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.003059/1.37, allocations: 3.382 MB / 1.163 GB, free: 13.64 MB / 0.795 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.005354/1.375, allocations: 5.391 MB / 1.169 GB, free: 8.047 MB / 0.795 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.107e-06/1.375, allocations: 8 kB / 1.169 GB, free: 8.039 MB / 0.795 GB
Notification: Performance of matching and sorting (n=499) (initialization_lambda0): time 0.008485/1.384, allocations: 6.534 MB / 1.175 GB, free: 1.617 MB / 0.795 GB
Notification: Performance of prepare postOptimizeDAE: time 3.198e-05/1.384, allocations: 45.7 kB / 1.175 GB, free: 1.566 MB / 0.795 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.169e-05/1.384, allocations: 20 kB / 1.175 GB, free: 1.547 MB / 0.795 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0009293/1.385, allocations: 452.8 kB / 1.176 GB, free: 1.102 MB / 0.795 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002841/1.387, allocations: 0.7555 MB / 1.176 GB, free: 396 kB / 0.795 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.007445/1.395, allocations: 6.144 MB / 1.182 GB, free: 10.07 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005434/1.4, allocations: 378.5 kB / 1.183 GB, free: 9.703 MB / 0.8106 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0005146/1.401, allocations: 172 kB / 1.183 GB, free: 9.535 MB / 0.8106 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 99
 * Number of states: 0 ()
 * Number of discrete variables: 5 (y.count,$PRE.y.count,y.T_start,$PRE.y.T_start,$whenCondition1)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (368):
 * Single equations (assignments): 357
 * Array equations: 3
 * Algorithm blocks: 1
 * Record equations: 3
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 3
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details (not torn):
 * Constant Jacobian (size): 0 systems
 * Linear Jacobian (size,density): 0 systems
 * Non-linear Jacobian (size): 3 systems
   {1, 1, 1}
 * Without analytic Jacobian (size): 0 systems
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 0 systems
 * Non-linear torn systems (#iteration vars, #inner vars): 1 system
   {(1,4)}
Notification: Performance of prepare postOptimizeDAE: time 0.0007702/1.402, allocations: 351 kB / 1.183 GB, free: 9.23 MB / 0.8106 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001117/1.403, allocations: 0.5243 MB / 1.184 GB, free: 8.699 MB / 0.8106 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.006619/1.409, allocations: 3.032 MB / 1.187 GB, free: 5.66 MB / 0.8106 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.004817/1.414, allocations: 2.581 MB / 1.189 GB, free: 3.012 MB / 0.8106 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 5.511e-06/1.414, allocations: 0 / 1.189 GB, free: 3.012 MB / 0.8106 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00226/1.417, allocations: 0.8999 MB / 1.19 GB, free: 2.086 MB / 0.8106 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0007415/1.417, allocations: 32 kB / 1.19 GB, free: 2.055 MB / 0.8106 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002626/1.42, allocations: 157.2 kB / 1.19 GB, free: 1.902 MB / 0.8106 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0002371/1.42, allocations: 113.2 kB / 1.19 GB, free: 1.789 MB / 0.8106 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.007184/1.427, allocations: 2.992 MB / 1.193 GB, free: 14.81 MB / 0.8262 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.00783/1.435, allocations: 4.418 MB / 1.198 GB, free: 10.37 MB / 0.8262 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.002143/1.437, allocations: 1.173 MB / 1.199 GB, free: 9.199 MB / 0.8262 GB
Notification: Performance of sorting global known variables: time 0.006533/1.444, allocations: 4.535 MB / 1.203 GB, free: 4.676 MB / 0.8262 GB
Notification: Performance of Backend: time 4.6e-07/1.444, allocations: 0 / 1.203 GB, free: 4.676 MB / 0.8262 GB
Notification: Performance of simCode: created initialization part: time 0.01593/1.46, allocations: 8.122 MB / 1.211 GB, free: 12.8 MB / 0.8419 GB
Notification: Performance of SimCode: time 0.02193/1.482, allocations: 12.81 MB / 1.224 GB, free: 8 kB / 0.8419 GB
Notification: Performance of Templates: time 0.198/1.68, allocations: 138.3 MB / 1.359 GB, free: 7.324 MB / 0.9825 GB
make -j1 -f IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic.makefile
(rm -f IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe ; mkfifo IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe ; head -c 1048576 < IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe >> ../files/IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic.sim & ./IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic  -abortSlowSimulation -alarm=480 -lv LOG_STATS > IBPSA_latest_IBPSA.Fluid.Movers.Validation.ControlledFlowMachineDynamic.pipe 2>&1)