Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.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 9.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo)
Running command: translateModel(Buildings.Fluid.Movers.Validation.FlowControlled_m_flow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow")
translateModel(Buildings.Fluid.Movers.Validation.FlowControlled_m_flow,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 9.0.0-master/package.mo): time 1.65/1.65, allocations: 297.8 MB / 313.7 MB, free: 136 kB / 234.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001053/0.001053, allocations: 184.5 kB / 384.6 MB, free: 10.85 MB / 314.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.443/1.443, allocations: 223.2 MB / 0.6626 GB, free: 4.266 MB / 490.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0008493/0.0008493, allocations: 91.73 kB / 0.7808 GB, free: 50.5 MB / 0.5573 GB
Notification: Performance of FrontEnd - loaded program: time 0.000468/0.0004681, allocations: 12 kB / 0.9088 GB, free: 2.867 MB / 0.6198 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7934/0.7939, allocations: 120.3 MB / 1.026 GB, free: 55.8 MB / 0.7292 GB
Notification: Performance of FrontEnd - scodeFlatten: time 4.514/5.308, allocations: 1.937 GB / 2.964 GB, free: 273.5 MB / 0.9792 GB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0002897/5.309, allocations: 99.5 kB / 2.964 GB, free: 273.5 MB / 0.9792 GB
Notification: Performance of FrontEnd - DAE generated: time 5.993/11.3, allocations: 1.669 GB / 4.633 GB, free: 93.96 MB / 1.01 GB
Notification: Performance of FrontEnd: time 2.675e-06/11.3, allocations: 0 / 4.633 GB, free: 93.96 MB / 1.01 GB
Notification: Performance of Transformations before backend: time 0.000433/11.3, allocations: 64.27 kB / 4.633 GB, free: 93.95 MB / 1.01 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 341
 * Number of variables: 341
Notification: Performance of Generate backend data structure: time 0.01129/11.31, allocations: 3.142 MB / 4.636 GB, free: 91.71 MB / 1.01 GB
Notification: Performance of prepare preOptimizeDAE: time 4.457e-05/11.31, allocations: 11.59 kB / 4.636 GB, free: 91.71 MB / 1.01 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.005882/11.32, allocations: 0.8191 MB / 4.637 GB, free: 91.35 MB / 1.01 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.008155/11.33, allocations: 2.701 MB / 4.639 GB, free: 89.41 MB / 1.01 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0001725/11.33, allocations: 113.4 kB / 4.639 GB, free: 89.36 MB / 1.01 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0006144/11.33, allocations: 144.2 kB / 4.64 GB, free: 89.32 MB / 1.01 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.004311/11.33, allocations: 1.599 MB / 4.641 GB, free: 88.31 MB / 1.01 GB
Notification: Performance of preOpt findStateOrder (simulation): time 5.148e-05/11.33, allocations: 7.812 kB / 4.641 GB, free: 88.31 MB / 1.01 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0002392/11.33, allocations: 55.44 kB / 4.641 GB, free: 88.27 MB / 1.01 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 5.067e-05/11.33, allocations: 54.69 kB / 4.641 GB, free: 88.25 MB / 1.01 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.003028/11.34, allocations: 1.268 MB / 4.643 GB, free: 87.61 MB / 1.01 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.01121/11.35, allocations: 7.461 MB / 4.65 GB, free: 81.13 MB / 1.01 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.001646/11.35, allocations: 1.027 MB / 4.651 GB, free: 80.46 MB / 1.01 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.000888/11.35, allocations: 481.7 kB / 4.651 GB, free: 80.23 MB / 1.01 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.0002102/11.35, allocations: 112.8 kB / 4.651 GB, free: 80.11 MB / 1.01 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 3.125e-05/11.35, allocations: 43.16 kB / 4.651 GB, free: 80.07 MB / 1.01 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.001362/11.35, allocations: 223.5 kB / 4.652 GB, free: 79.95 MB / 1.01 GB
Notification: Performance of pre-optimization done (n=79): time 5.982e-06/11.35, allocations: 0 / 4.652 GB, free: 79.95 MB / 1.01 GB
Notification: Performance of matching and sorting (n=79): time 0.004636/11.36, allocations: 1.61 MB / 4.653 GB, free: 79.08 MB / 1.01 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 3.654e-05/11.36, allocations: 63.16 kB / 4.653 GB, free: 79.01 MB / 1.01 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.003184/11.36, allocations: 1.737 MB / 4.655 GB, free: 78.05 MB / 1.01 GB
Notification: Performance of collectPreVariables (initialization): time 0.0001614/11.36, allocations: 48.52 kB / 4.655 GB, free: 78 MB / 1.01 GB
Notification: Performance of collectInitialEqns (initialization): time 0.0007894/11.36, allocations: 0.9703 MB / 4.656 GB, free: 77.15 MB / 1.01 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002483/11.36, allocations: 274.3 kB / 4.656 GB, free: 76.91 MB / 1.01 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 6.513e-05/11.36, allocations: 19.28 kB / 4.656 GB, free: 76.9 MB / 1.01 GB
Notification: Performance of setup shared object (initialization): time 8.268e-05/11.36, allocations: 353.4 kB / 4.657 GB, free: 76.56 MB / 1.01 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.000823/11.36, allocations: 383.2 kB / 4.657 GB, free: 76.38 MB / 1.01 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.00104/11.36, allocations: 0.8161 MB / 4.658 GB, free: 75.6 MB / 1.01 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.00188/11.37, allocations: 1.137 MB / 4.659 GB, free: 74.77 MB / 1.01 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 9.177e-06/11.37, allocations: 0 / 4.659 GB, free: 74.77 MB / 1.01 GB
Notification: Performance of matching and sorting (n=129) (initialization): time 0.003336/11.37, allocations: 1.428 MB / 4.66 GB, free: 74.03 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001882/11.37, allocations: 390.4 kB / 4.661 GB, free: 73.53 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 1.947e-05/11.37, allocations: 8.344 kB / 4.661 GB, free: 73.53 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0004228/11.37, allocations: 120.3 kB / 4.661 GB, free: 73.41 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.001095/11.37, allocations: 263.6 kB / 4.661 GB, free: 73.16 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.002498/11.37, allocations: 2.398 MB / 4.663 GB, free: 70.61 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.002015/11.37, allocations: 143.6 kB / 4.663 GB, free: 70.47 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001553/11.38, allocations: 59.97 kB / 4.664 GB, free: 70.41 MB / 1.01 GB
Notification: Performance of prepare postOptimizeDAE: time 8.627e-06/11.38, allocations: 4 kB / 4.664 GB, free: 70.41 MB / 1.01 GB
Notification: Performance of postOpt replaceHomotopyWithSimplified (initialization): time 0.002552/11.38, allocations: 1.172 MB / 4.665 GB, free: 69.23 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 2.232e-05/11.38, allocations: 12 kB / 4.665 GB, free: 69.22 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0003352/11.38, allocations: 108.8 kB / 4.665 GB, free: 69.11 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.0008336/11.38, allocations: 239.6 kB / 4.665 GB, free: 68.88 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.00222/11.38, allocations: 1.805 MB / 4.667 GB, free: 66.95 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00206/11.38, allocations: 139.6 kB / 4.667 GB, free: 66.81 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0001301/11.38, allocations: 51.98 kB / 4.667 GB, free: 66.76 MB / 1.01 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 44
 * 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 (123):
 * Single equations (assignments): 119
 * Array equations: 2
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {1 4}
Notification: Performance of prepare postOptimizeDAE: time 0.001438/11.38, allocations: 0.5824 MB / 4.668 GB, free: 66.17 MB / 1.01 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0005595/11.39, allocations: 197.7 kB / 4.668 GB, free: 65.97 MB / 1.01 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.003282/11.39, allocations: 1.17 MB / 4.669 GB, free: 64.8 MB / 1.01 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 1.034e-05/11.39, allocations: 8 kB / 4.669 GB, free: 64.79 MB / 1.01 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.128e-06/11.39, allocations: 3.938 kB / 4.669 GB, free: 64.79 MB / 1.01 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.002139/11.39, allocations: 0.9732 MB / 4.67 GB, free: 63.78 MB / 1.01 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.007217/11.4, allocations: 2.979 MB / 4.673 GB, free: 60.67 MB / 1.01 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 6.041e-06/11.4, allocations: 0 / 4.673 GB, free: 60.67 MB / 1.01 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0008959/11.4, allocations: 191.8 kB / 4.673 GB, free: 60.48 MB / 1.01 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0003185/11.4, allocations: 104.7 kB / 4.673 GB, free: 60.38 MB / 1.01 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 7.555e-05/11.4, allocations: 23.98 kB / 4.673 GB, free: 60.36 MB / 1.01 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.002069/11.4, allocations: 2.284 MB / 4.675 GB, free: 57.91 MB / 1.01 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 4.027e-06/11.4, allocations: 4.031 kB / 4.675 GB, free: 57.9 MB / 1.01 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.003522/11.41, allocations: 1.694 MB / 4.677 GB, free: 56.17 MB / 1.01 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001083/11.41, allocations: 354.5 kB / 4.677 GB, free: 55.8 MB / 1.01 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.000523/11.41, allocations: 12 kB / 4.677 GB, free: 55.79 MB / 1.01 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.001566/11.41, allocations: 139.7 kB / 4.677 GB, free: 55.66 MB / 1.01 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0001278/11.41, allocations: 52.58 kB / 4.677 GB, free: 55.61 MB / 1.01 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 7.749e-05/11.41, allocations: 31.97 kB / 4.678 GB, free: 55.57 MB / 1.01 GB
Notification: Performance of sorting global known variables: time 0.002298/11.41, allocations: 1.176 MB / 4.679 GB, free: 54.38 MB / 1.01 GB
Notification: Performance of sort global known variables: time 1.71e-07/11.41, allocations: 3.938 kB / 4.679 GB, free: 54.38 MB / 1.01 GB
Notification: Performance of remove unused functions: time 0.005315/11.42, allocations: 1.388 MB / 4.68 GB, free: 52.98 MB / 1.01 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 7
 * Number of states: 3 (floMacDyn.vol.dynBal.U,floMacDyn.vol.dynBal.m,floMacDyn.vol.dynBal.mXi[1])
 * 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 (77):
 * Single equations (assignments): 75
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 1
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Equation system details:
 * Constant Jacobian: 0
 * Linear Jacobian (size,density): 0
 * Non-linear Jacobian: 1 {1}
 * Without analytic Jacobian: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 0
 * Non-linear torn systems: 1 {1 4}
Notification: Performance of Backend phase and start with SimCode phase: time 0.006354/11.42, allocations: 4.221 MB / 4.684 GB, free: 48.56 MB / 1.01 GB
Notification: Performance of simCode: created initialization part: time 0.004316/11.43, allocations: 1.811 MB / 4.686 GB, free: 46.73 MB / 1.01 GB
Notification: Performance of simCode: created event and clocks part: time 6.402e-06/11.43, allocations: 0 / 4.686 GB, free: 46.73 MB / 1.01 GB
Notification: Performance of simCode: created simulation system equations: time 0.001113/11.43, allocations: 0.573 MB / 4.686 GB, free: 46.14 MB / 1.01 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.005696/11.43, allocations: 0.9871 MB / 4.687 GB, free: 45.2 MB / 1.01 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.007091/11.44, allocations: 4.205 MB / 4.692 GB, free: 40.95 MB / 1.01 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.001664/11.44, allocations: 1.57 MB / 4.693 GB, free: 39.35 MB / 1.01 GB
Notification: Performance of simCode: alias equations: time 0.002615/11.45, allocations: 487.1 kB / 4.694 GB, free: 38.9 MB / 1.01 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0005118/11.45, allocations: 151.4 kB / 4.694 GB, free: 38.75 MB / 1.01 GB
Notification: Performance of SimCode: time 1.353e-06/11.45, allocations: 4 kB / 4.694 GB, free: 38.75 MB / 1.01 GB
Notification: Performance of Templates: time 0.7451/12.19, allocations: 76.71 MB / 4.769 GB, free: 136 MB / 1.042 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.makefile
(rm -f Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe >> ../files/Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.sim & ./Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow -abortSlowSimulation -alarm=480 -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Movers.Validation.FlowControlled_m_flow.pipe 2>&1)