Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5.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/Buildings 10.1.1-maint.10.0.x/package.mo", uses=false)
Using package Buildings with version 10.1.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/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(Buildings.Fluid.Examples.FlowSystem.Simplified5,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pmpNorth.m_flow|pmpSouth.m_flow",fileNamePrefix="Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5")
translateModel(Buildings.Fluid.Examples.FlowSystem.Simplified5,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pmpNorth.m_flow|pmpSouth.m_flow",fileNamePrefix="Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.00145/0.00145, allocations: 118.7 kB / 16.42 MB, free: 6.5 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.001105/0.001106, allocations: 183.9 kB / 17.35 MB, free: 5.762 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.286/1.286, allocations: 222.9 MB / 241 MB, free: 15.14 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 10.1.1-maint.10.0.x/package.mo): time 2.37/2.37, allocations: 437 MB / 0.7112 GB, free: 4.449 MB / 0.5762 GB
Notification: Performance of FrontEnd - loaded program: time 0.001287/0.001287, allocations: 75.81 kB / 1.019 GB, free: 9.312 MB / 0.795 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7479/0.7492, allocations: 151.6 MB / 1.167 GB, free: 3.887 MB / 0.8887 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.FlowSystem.Simplified5): time 0.308/1.057, allocations: 357.8 MB / 1.517 GB, free: 12.86 MB / 1.248 GB
Notification: Performance of NFInst.instExpressions: time 0.7291/1.786, allocations: 75.85 MB / 1.591 GB, free: 61.88 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01277/1.799, allocations: 432.2 kB / 1.591 GB, free: 61.88 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.01374/1.813, allocations: 5.874 MB / 1.597 GB, free: 61.87 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.02802/1.841, allocations: 12.2 MB / 1.609 GB, free: 61.43 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.01715/1.858, allocations: 8.317 MB / 1.617 GB, free: 61.16 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.07552/1.934, allocations: 65.98 MB / 1.682 GB, free: 58.84 MB / 1.279 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02029/1.954, allocations: 17.38 MB / 1.699 GB, free: 46.82 MB / 1.279 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.02808/1.982, allocations: 14.88 MB / 1.713 GB, free: 37.12 MB / 1.279 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02136/2.004, allocations: 14.01 MB / 1.727 GB, free: 25.16 MB / 1.279 GB
Notification: Performance of NFPackage.collectConstants: time 0.006188/2.01, allocations: 1.621 MB / 1.728 GB, free: 23.54 MB / 1.279 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01583/2.026, allocations: 5.118 MB / 1.733 GB, free: 18.84 MB / 1.279 GB
Notification: Performance of NFScalarize.scalarize: time 0.007424/2.033, allocations: 5.476 MB / 1.739 GB, free: 13.66 MB / 1.279 GB
Notification: Performance of NFVerifyModel.verify: time 0.01675/2.05, allocations: 9.437 MB / 1.748 GB, free: 4.523 MB / 1.279 GB
Notification: Performance of NFConvertDAE.convert: time 0.03626/2.086, allocations: 25.96 MB / 1.773 GB, free: 11.61 MB / 1.311 GB
Notification: Performance of FrontEnd - DAE generated: time 5.61e-06/2.086, allocations: 0 / 1.773 GB, free: 11.61 MB / 1.311 GB
Notification: Performance of FrontEnd: time 1.713e-06/2.086, allocations: 0 / 1.773 GB, free: 11.61 MB / 1.311 GB
Notification: Performance of Transformations before backend: time 0.0006748/2.087, allocations: 0 / 1.773 GB, free: 11.61 MB / 1.311 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1537
 * Number of variables: 1537
Notification: Performance of Generate backend data structure: time 0.05794/2.145, allocations: 20.3 MB / 1.793 GB, free: 7.41 MB / 1.326 GB
Notification: Performance of prepare preOptimizeDAE: time 4.767e-05/2.145, allocations: 8.922 kB / 1.793 GB, free: 7.402 MB / 1.326 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01832/2.163, allocations: 3.227 MB / 1.796 GB, free: 4.152 MB / 1.326 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.0382/2.201, allocations: 17.93 MB / 1.814 GB, free: 2.535 MB / 1.342 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.000585/2.202, allocations: 0.5196 MB / 1.814 GB, free: 2.012 MB / 1.342 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003517/2.206, allocations: 0.6953 MB / 1.815 GB, free: 1.316 MB / 1.342 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03323/2.239, allocations: 14.66 MB / 1.829 GB, free: 2.457 MB / 1.357 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002334/2.239, allocations: 7.938 kB / 1.829 GB, free: 2.449 MB / 1.357 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002633/2.242, allocations: 248 kB / 1.829 GB, free: 2.207 MB / 1.357 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001312/2.242, allocations: 148 kB / 1.83 GB, free: 2.062 MB / 1.357 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03656/2.278, allocations: 19.54 MB / 1.849 GB, free: 14.51 MB / 1.389 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.1318/2.41, allocations: 74.37 MB / 1.921 GB, free: 1.672 MB / 1.451 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02104/2.431, allocations: 11.13 MB / 1.932 GB, free: 6.766 MB / 1.467 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.01567/2.447, allocations: 9.324 MB / 1.941 GB, free: 13.44 MB / 1.482 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 evalFunc (simulation): time 0.06694/2.514, allocations: 31.69 MB / 1.972 GB, free: 13.54 MB / 1.514 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01768/2.532, allocations: 9.346 MB / 1.981 GB, free: 4.152 MB / 1.514 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.02116/2.553, allocations: 5.839 MB / 1.987 GB, free: 14.48 MB / 1.529 GB
Notification: Performance of pre-optimization done (n=399): time 2.722e-05/2.553, allocations: 0 / 1.987 GB, free: 14.48 MB / 1.529 GB
Notification: Performance of matching and sorting (n=585): time 1.689/4.242, allocations: 202.5 MB / 2.185 GB, free: 0.7309 GB / 1.701 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 6.499e-05/4.242, allocations: 111.4 kB / 2.185 GB, free: 0.7308 GB / 1.701 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02316/4.266, allocations: 15.49 MB / 2.2 GB, free: 0.726 GB / 1.701 GB
Notification: Performance of collectPreVariables (initialization): time 0.003236/4.269, allocations: 172.7 kB / 2.2 GB, free: 0.7259 GB / 1.701 GB
Notification: Performance of collectInitialEqns (initialization): time 0.005124/4.274, allocations: 6.483 MB / 2.207 GB, free: 0.722 GB / 1.701 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003545/4.278, allocations: 1.993 MB / 2.209 GB, free: 0.7217 GB / 1.701 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004748/4.282, allocations: 2.844 MB / 2.211 GB, free: 0.721 GB / 1.701 GB
Notification: Performance of setup shared object (initialization): time 4.125e-05/4.282, allocations: 305.1 kB / 2.212 GB, free: 0.7207 GB / 1.701 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01705/4.299, allocations: 11.45 MB / 2.223 GB, free: 0.7167 GB / 1.701 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.02014/4.32, allocations: 13.92 MB / 2.236 GB, free: 0.7101 GB / 1.701 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03901/4.359, allocations: 24.48 MB / 2.26 GB, free: 0.6978 GB / 1.701 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.725e-05/4.359, allocations: 10.22 kB / 2.26 GB, free: 0.6978 GB / 1.701 GB
Notification: Performance of matching and sorting (n=1226) (initialization): time 0.6916/5.05, allocations: 129.1 MB / 2.386 GB, free: 0.5746 GB / 1.701 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001524/5.051, allocations: 52.34 kB / 2.386 GB, free: 0.5745 GB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001162/5.051, allocations: 44 kB / 2.386 GB, free: 0.5745 GB / 1.701 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.7001/5.751, allocations: 136.4 MB / 2.52 GB, free: 452 MB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01171/5.763, allocations: 2.176 MB / 2.522 GB, free: 449.8 MB / 1.701 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.1837/5.946, allocations: 99.93 MB / 2.619 GB, free: 349.5 MB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.02821/5.975, allocations: 0.9754 MB / 2.62 GB, free: 348.5 MB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004801/5.979, allocations: 0.7958 MB / 2.621 GB, free: 347.7 MB / 1.701 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.04496/6.024, allocations: 14.07 MB / 2.635 GB, free: 333.6 MB / 1.701 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.03229/6.057, allocations: 13.39 MB / 2.648 GB, free: 319.3 MB / 1.701 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03739/6.094, allocations: 23.47 MB / 2.671 GB, free: 295.1 MB / 1.701 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 4.555e-05/6.094, allocations: 12 kB / 2.671 GB, free: 295.1 MB / 1.701 GB
Notification: Performance of matching and sorting (n=1226) (initialization_lambda0): time 0.6706/6.765, allocations: 127.6 MB / 2.795 GB, free: 167.4 MB / 1.701 GB
Notification: Performance of prepare postOptimizeDAE: time 7.111e-05/6.765, allocations: 49.7 kB / 2.795 GB, free: 167.4 MB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.142e-05/6.765, allocations: 48.16 kB / 2.796 GB, free: 167.3 MB / 1.701 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.6899/7.455, allocations: 136.1 MB / 2.928 GB, free: 31.34 MB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01035/7.465, allocations: 2.153 MB / 2.93 GB, free: 29.18 MB / 1.701 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.7791/8.244, allocations: 104.6 MB / 3.033 GB, free: 0.6794 GB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01667/8.261, allocations: 1.016 MB / 3.034 GB, free: 0.6789 GB / 1.701 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002884/8.264, allocations: 0.7691 MB / 3.034 GB, free: 0.6786 GB / 1.701 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 203
 * Number of states: 0 ()
 * Number of discrete variables: 10 ($whenCondition1,stepValve.count,$PRE.stepValve.count,stepValve.T_start,$PRE.stepValve.T_start,pumpHea.stage,stepPump.pulseStart,$PRE.stepPump.pulseStart,stepPump.y,$whenCondition2)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (819):
 * Single equations (assignments): 801
 * Array equations: 4
 * Algorithm blocks: 1
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 3
 * 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): 6 systems
   {1, 1, 1, 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): 1 system
   {(34,41,81.4%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(5,80), (7,78)}
Notification: Performance of prepare postOptimizeDAE: time 0.003221/8.267, allocations: 0.636 MB / 3.035 GB, free: 0.6782 GB / 1.701 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.004197/8.271, allocations: 1.349 MB / 3.036 GB, free: 0.6782 GB / 1.701 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.2281/8.5, allocations: 53.12 MB / 3.088 GB, free: 0.6304 GB / 1.701 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.2152/8.715, allocations: 47.42 MB / 3.134 GB, free: 0.5842 GB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.808e-05/8.715, allocations: 0 / 3.134 GB, free: 0.5842 GB / 1.701 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.008424/8.723, allocations: 2.847 MB / 3.137 GB, free: 0.5822 GB / 1.701 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004291/8.728, allocations: 126.8 kB / 3.137 GB, free: 0.582 GB / 1.701 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01354/8.741, allocations: 0.7725 MB / 3.138 GB, free: 0.5813 GB / 1.701 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00531/8.747, allocations: 0.9416 MB / 3.139 GB, free: 0.5804 GB / 1.701 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.0683/8.815, allocations: 24.02 MB / 3.163 GB, free: 0.5572 GB / 1.701 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.05445/8.869, allocations: 26.41 MB / 3.188 GB, free: 0.5315 GB / 1.701 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.01444/8.884, allocations: 8.224 MB / 3.196 GB, free: 0.5234 GB / 1.701 GB
Notification: Performance of sorting global known variables: time 0.01737/8.901, allocations: 10.59 MB / 3.207 GB, free: 0.5131 GB / 1.701 GB
Notification: Performance of Backend: time 9.61e-07/8.901, allocations: 0 / 3.207 GB, free: 0.5131 GB / 1.701 GB
Notification: Performance of simCode: created initialization part: time 0.088/8.989, allocations: 36.04 MB / 3.242 GB, free: 489.7 MB / 1.701 GB
Notification: Performance of SimCode: time 0.05607/9.045, allocations: 32.98 MB / 3.274 GB, free: 457 MB / 1.701 GB
Notification: Performance of Templates: time 1.595/10.64, allocations: 466.6 MB / 3.73 GB, free: 0.7152 GB / 1.701 GB
make -j1 -f Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5.makefile
(rm -f Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5.pipe ; mkfifo Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5.pipe ; head -c 1048576 < Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5.pipe >> ../files/Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5.sim & ./Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_10_Buildings.Fluid.Examples.FlowSystem.Simplified5.pipe 2>&1)