Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6.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 12.0.0-master/package.mo", uses=false)
Using package Buildings with version 12.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.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(Buildings.Fluid.Examples.FlowSystem.Simplified6,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pmpNorth.m_flow|pmpSouth.m_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6")
translateModel(Buildings.Fluid.Examples.FlowSystem.Simplified6,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|pmpNorth.m_flow|pmpSouth.m_flow",fileNamePrefix="Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001417/0.001416, allocations: 119 kB / 16.42 MB, free: 6.492 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.001433/0.001433, allocations: 183.9 kB / 17.34 MB, free: 5.746 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.327/1.327, allocations: 222.9 MB / 241.1 MB, free: 15.2 MB / 206.1 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Buildings 12.0.0-master/package.mo): time 2.786/2.786, allocations: 472.7 MB / 0.746 GB, free: 488 kB / 0.6075 GB
Notification: Performance of FrontEnd - loaded program: time 0.001383/0.001383, allocations: 67.89 kB / 1.07 GB, free: 9.406 MB / 0.8419 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.7093/0.7107, allocations: 159.9 MB / 1.226 GB, free: 13.47 MB / 0.9512 GB
Notification: Performance of NFInst.instantiate(Buildings.Fluid.Examples.FlowSystem.Simplified6): time 1.08/1.791, allocations: 357.9 MB / 1.576 GB, free: 61.74 MB / 1.279 GB
Notification: Performance of NFInst.instExpressions: time 0.09139/1.882, allocations: 75.88 MB / 1.65 GB, free: 60.7 MB / 1.279 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01586/1.898, allocations: 433.6 kB / 1.651 GB, free: 60.7 MB / 1.279 GB
Notification: Performance of NFTyping.typeComponents: time 0.01588/1.914, allocations: 5.878 MB / 1.656 GB, free: 60.58 MB / 1.279 GB
Notification: Performance of NFTyping.typeBindings: time 0.03167/1.946, allocations: 12.2 MB / 1.668 GB, free: 60.1 MB / 1.279 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02069/1.966, allocations: 8.314 MB / 1.676 GB, free: 59.85 MB / 1.279 GB
Notification: Performance of NFFlatten.flatten: time 0.09634/2.063, allocations: 65.95 MB / 1.741 GB, free: 23.7 MB / 1.279 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02537/2.088, allocations: 16.34 MB / 1.757 GB, free: 7.832 MB / 1.279 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03081/2.119, allocations: 13.23 MB / 1.77 GB, free: 11.32 MB / 1.295 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02095/2.14, allocations: 10.36 MB / 1.78 GB, free: 1.723 MB / 1.295 GB
Notification: Performance of NFPackage.collectConstants: time 0.005841/2.146, allocations: 1.145 MB / 1.781 GB, free: 0.5781 MB / 1.295 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01756/2.163, allocations: 4.648 MB / 1.785 GB, free: 12.13 MB / 1.311 GB
Notification: Performance of NFScalarize.scalarize: time 0.007301/2.171, allocations: 4.34 MB / 1.79 GB, free: 7.875 MB / 1.311 GB
Notification: Performance of NFVerifyModel.verify: time 0.02011/2.191, allocations: 8.31 MB / 1.798 GB, free: 15.61 MB / 1.326 GB
Notification: Performance of NFConvertDAE.convert: time 0.04726/2.238, allocations: 21.86 MB / 1.819 GB, free: 10.46 MB / 1.342 GB
Notification: Performance of FrontEnd - DAE generated: time 9.387e-06/2.238, allocations: 4 kB / 1.819 GB, free: 10.45 MB / 1.342 GB
Notification: Performance of FrontEnd: time 1.573e-06/2.238, allocations: 0 / 1.819 GB, free: 10.45 MB / 1.342 GB
Notification: Performance of Transformations before backend: time 0.0009762/2.239, allocations: 0 / 1.819 GB, free: 10.45 MB / 1.342 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.05087/2.29, allocations: 18.07 MB / 1.837 GB, free: 8.457 MB / 1.357 GB
Notification: Performance of prepare preOptimizeDAE: time 5.752e-05/2.29, allocations: 12.03 kB / 1.837 GB, free: 8.445 MB / 1.357 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01692/2.307, allocations: 3.178 MB / 1.84 GB, free: 5.254 MB / 1.357 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03942/2.347, allocations: 17.03 MB / 1.856 GB, free: 4.504 MB / 1.373 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0006811/2.347, allocations: 0.5196 MB / 1.857 GB, free: 3.98 MB / 1.373 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002693/2.35, allocations: 0.6953 MB / 1.858 GB, free: 3.285 MB / 1.373 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02426/2.374, allocations: 9.609 MB / 1.867 GB, free: 9.285 MB / 1.389 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002728/2.375, allocations: 27.75 kB / 1.867 GB, free: 9.258 MB / 1.389 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001868/2.377, allocations: 252 kB / 1.867 GB, free: 9.012 MB / 1.389 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001603/2.377, allocations: 160 kB / 1.867 GB, free: 8.855 MB / 1.389 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02021/2.397, allocations: 7.971 MB / 1.875 GB, free: 0.875 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.09139/2.488, allocations: 51.59 MB / 1.926 GB, free: 10.47 MB / 1.451 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01396/2.502, allocations: 6.03 MB / 1.931 GB, free: 4.711 MB / 1.451 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00869/2.511, allocations: 4.202 MB / 1.936 GB, free: 0.5156 MB / 1.451 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.03732/2.549, allocations: 14.31 MB / 1.95 GB, free: 2.043 MB / 1.467 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.009381/2.558, allocations: 4.203 MB / 1.954 GB, free: 13.8 MB / 1.482 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.007825/2.566, allocations: 1.153 MB / 1.955 GB, free: 12.68 MB / 1.482 GB
Notification: Performance of pre-optimization done (n=332): time 1.702e-05/2.566, allocations: 0 / 1.955 GB, free: 12.68 MB / 1.482 GB
Notification: Performance of matching and sorting (n=518): time 0.2037/2.77, allocations: 56.43 MB / 2.01 GB, free: 3.277 MB / 1.529 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 9.043e-05/2.77, allocations: 111.5 kB / 2.01 GB, free: 3.152 MB / 1.529 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.03643/2.806, allocations: 15.76 MB / 2.025 GB, free: 3.484 MB / 1.545 GB
Notification: Performance of collectPreVariables (initialization): time 0.00213/2.808, allocations: 161.7 kB / 2.026 GB, free: 3.32 MB / 1.545 GB
Notification: Performance of collectInitialEqns (initialization): time 0.009464/2.818, allocations: 6.781 MB / 2.032 GB, free: 12.58 MB / 1.561 GB
Notification: Performance of collectInitialBindings (initialization): time 0.003334/2.821, allocations: 1.854 MB / 2.034 GB, free: 10.75 MB / 1.561 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.008297/2.829, allocations: 2.206 MB / 2.036 GB, free: 8.527 MB / 1.561 GB
Notification: Performance of setup shared object (initialization): time 0.0001377/2.83, allocations: 309 kB / 2.036 GB, free: 8.223 MB / 1.561 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01664/2.846, allocations: 7.269 MB / 2.044 GB, free: 0.9375 MB / 1.561 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01952/2.866, allocations: 10.09 MB / 2.053 GB, free: 5.719 MB / 1.576 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03397/2.9, allocations: 16.22 MB / 2.069 GB, free: 4.625 MB / 1.592 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.415e-05/2.9, allocations: 20 kB / 2.069 GB, free: 4.605 MB / 1.592 GB
Notification: Performance of matching and sorting (n=1222) (initialization): time 0.05901/2.959, allocations: 22.26 MB / 2.091 GB, free: 14.26 MB / 1.623 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001269/2.959, allocations: 57.7 kB / 2.091 GB, free: 14.2 MB / 1.623 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001121/2.959, allocations: 60 kB / 2.091 GB, free: 14.14 MB / 1.623 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01813/2.977, allocations: 4.984 MB / 2.096 GB, free: 9.172 MB / 1.623 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01378/2.991, allocations: 2.301 MB / 2.098 GB, free: 6.867 MB / 1.623 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02017/3.011, allocations: 14.84 MB / 2.113 GB, free: 7.602 MB / 1.639 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01628/3.028, allocations: 0.9491 MB / 2.114 GB, free: 6.652 MB / 1.639 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002839/3.031, allocations: 0.5153 MB / 2.114 GB, free: 6.137 MB / 1.639 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02363/3.054, allocations: 9.886 MB / 2.124 GB, free: 12.23 MB / 1.654 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01994/3.074, allocations: 9.567 MB / 2.133 GB, free: 1.531 MB / 1.654 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.0324/3.107, allocations: 15.19 MB / 2.148 GB, free: 1.441 MB / 1.67 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 9.336e-05/3.107, allocations: 16 kB / 2.148 GB, free: 1.426 MB / 1.67 GB
Notification: Performance of matching and sorting (n=1222) (initialization_lambda0): time 0.05634/3.163, allocations: 20.7 MB / 2.168 GB, free: 12.64 MB / 1.701 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001145/3.163, allocations: 57.7 kB / 2.168 GB, free: 12.58 MB / 1.701 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001058/3.163, allocations: 59.94 kB / 2.168 GB, free: 12.52 MB / 1.701 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01511/3.179, allocations: 4.626 MB / 2.173 GB, free: 7.902 MB / 1.701 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01228/3.191, allocations: 2.286 MB / 2.175 GB, free: 5.613 MB / 1.701 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02832/3.219, allocations: 19.2 MB / 2.194 GB, free: 1.879 MB / 1.717 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01548/3.235, allocations: 1.003 MB / 2.195 GB, free: 0.875 MB / 1.717 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002655/3.237, allocations: 499.6 kB / 2.195 GB, free: 400 kB / 1.717 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 269
 * 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 (883):
 * Single equations (assignments): 864
 * Array equations: 4
 * Algorithm blocks: 1
 * Record equations: 4
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 6
 * Torn equation systems: 4
 * 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): 2 systems
   {(1,3,100.0%), (1,3,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(7,78), (7,78)}
Notification: Performance of prepare postOptimizeDAE: time 0.7416/3.979, allocations: 0.6511 MB / 2.196 GB, free: 0.7052 GB / 1.717 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.00582/3.985, allocations: 1.42 MB / 2.197 GB, free: 0.7052 GB / 1.717 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05316/4.038, allocations: 15.83 MB / 2.213 GB, free: 0.7044 GB / 1.717 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.03229/4.07, allocations: 12.76 MB / 2.225 GB, free: 0.7004 GB / 1.717 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.435e-05/4.071, allocations: 3.609 kB / 2.225 GB, free: 0.7004 GB / 1.717 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.007955/4.079, allocations: 2.514 MB / 2.228 GB, free: 0.6998 GB / 1.717 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004343/4.083, allocations: 103.8 kB / 2.228 GB, free: 0.6997 GB / 1.717 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.01263/4.096, allocations: 0.7523 MB / 2.228 GB, free: 0.6997 GB / 1.717 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001973/4.098, allocations: 0.5732 MB / 2.229 GB, free: 0.6996 GB / 1.717 GB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.06393/4.162, allocations: 13.93 MB / 2.243 GB, free: 0.6961 GB / 1.717 GB
Notification: Performance of postOpt symbolicJacobianDAE (simulation): time 0.07538/4.237, allocations: 18.14 MB / 2.26 GB, free: 0.6903 GB / 1.717 GB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.02298/4.26, allocations: 5.202 MB / 2.265 GB, free: 0.6857 GB / 1.717 GB
Notification: Performance of sorting global known variables: time 0.03389/4.294, allocations: 10.73 MB / 2.276 GB, free: 0.6753 GB / 1.717 GB
Notification: Performance of Backend: time 3.827e-06/4.294, allocations: 0 / 2.276 GB, free: 0.6753 GB / 1.717 GB
Notification: Performance of simCode: created initialization part: time 0.09725/4.391, allocations: 21.65 MB / 2.297 GB, free: 0.6547 GB / 1.717 GB
Notification: Performance of SimCode: time 0.07936/4.471, allocations: 32.15 MB / 2.328 GB, free: 0.6239 GB / 1.717 GB
Notification: Performance of Templates: time 0.6715/5.142, allocations: 337.2 MB / 2.658 GB, free: 304 MB / 1.717 GB
make -j1 -f Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6.makefile
(rm -f Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6.pipe ; mkfifo Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6.pipe ; head -c 1048576 < Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6.pipe >> ../files/Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6.sim & ./Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > Buildings_latest_Buildings.Fluid.Examples.FlowSystem.Simplified6.pipe 2>&1)