Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo): time 0.0008643/0.0008643, allocations: 79.69 kB / 19.25 MB, free: 0.6211 MB / 13.93 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo): time 0.000898/0.000898, allocations: 166 kB / 22.56 MB, free: 1.961 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo): time 0.8971/0.8971, allocations: 177.1 MB / 202.9 MB, free: 5.688 MB / 186.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/Building/BuildingEnvelope/HeatTransfer/package.mo:2:1-40:17:writable] Warning: Soil_case_nappe was referenced in the package.order file, but was not found in package.mo, Soil_case_nappe/package.mo or Soil_case_nappe.mo.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo): time 0.5562/0.5562, allocations: 110.2 MB / 369.6 MB, free: 12.59 MB / 346.7 MB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:44:3-56:20:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:58:3-65:19:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:67:3-72:20:writable] Warning: External function annotation should occur on the external-clause, not on the function.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/BoundaryConditions/Scenarios/CombiTimeTable.mo:74:3-79:20:writable] Warning: External function annotation should occur on the external-clause, not on the function.
"
[Timeout remaining time 179]
Using package BuildSysPro with version 3.6.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/BuildSysPro 3.7.0/package.mo)
Using package Modelica with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/package.mo)
Using package Complex with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.1.0+maint.om/package.mo)
Using package ModelicaServices with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.1.0+maint.om/package.mo)
Running command: "" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Examples_FlowSystem_Simplified3",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3,fileNamePrefix="BuildSysPro_BuildSysPro_IBPSA_Fluid_Examples_FlowSystem_Simplified3",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 2.956e-06/2.956e-06, allocations: 3.938 kB / 0.5475 GB, free: 9.66 MB / 0.5105 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 2.705e-05/3.001e-05, allocations: 2.281 kB / 0.5475 GB, free: 9.656 MB / 0.5105 GB
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pmpSouth.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pmpNorth.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pumpHea.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.1.0+maint.om/Blocks/Math.mo:543:5-544:48:writable] Warning: Parameter pumpCoo.gaiSpe.k has no value, and is fixed during initialization (fixed=true), using available start value (start=1) as default value.
Notification: Performance of NFInst.instantiate(BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3): time 0.4795/0.4795, allocations: 326.3 MB / 0.8662 GB, free: 7.426 MB / 0.6667 GB
Notification: Performance of NFInst.instExpressions: time 0.07677/0.5563, allocations: 71.09 MB / 0.9356 GB, free: 204 kB / 0.7292 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01384/0.5701, allocations: 0.5773 MB / 0.9362 GB, free: 15.61 MB / 0.7448 GB
Notification: Performance of NFTyping.typeComponents: time 0.01444/0.5846, allocations: 6.492 MB / 0.9425 GB, free: 9.086 MB / 0.7448 GB
Notification: Performance of NFTyping.typeBindings: time 0.03122/0.6158, allocations: 15.47 MB / 0.9576 GB, free: 9.539 MB / 0.7605 GB
Notification: Performance of NFTyping.typeClassSections: time 0.3914/1.007, allocations: 10.76 MB / 0.9681 GB, free: 26.17 MB / 0.7605 GB
Notification: Performance of NFFlatten.flatten: time 0.08743/1.095, allocations: 86.95 MB / 1.053 GB, free: 19.69 MB / 0.7605 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.02012/1.115, allocations: 15.87 MB / 1.069 GB, free: 18.27 MB / 0.7605 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.05078/1.166, allocations: 23.38 MB / 1.091 GB, free: 8.586 MB / 0.7605 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02562/1.191, allocations: 15.67 MB / 1.107 GB, free: 12.87 MB / 0.7761 GB
Notification: Performance of NFPackage.collectConstants: time 0.007547/1.199, allocations: 1.84 MB / 1.108 GB, free: 11.03 MB / 0.7761 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.01792/1.217, allocations: 5.075 MB / 1.113 GB, free: 6.895 MB / 0.7761 GB
Notification: Performance of NFScalarize.scalarize: time 0.01132/1.228, allocations: 6.672 MB / 1.12 GB, free: 1.324 MB / 0.7761 GB
Notification: Performance of NFVerifyModel.verify: time 0.01824/1.246, allocations: 7.735 MB / 1.127 GB, free: 9.965 MB / 0.7917 GB
Notification: Performance of NFConvertDAE.convert: time 0.03857/1.285, allocations: 33.25 MB / 1.16 GB, free: 10.27 MB / 0.823 GB
Notification: Performance of FrontEnd - DAE generated: time 1.01e-05/1.285, allocations: 4 kB / 1.16 GB, free: 10.27 MB / 0.823 GB
Notification: Performance of FrontEnd: time 2.806e-06/1.285, allocations: 0 / 1.16 GB, free: 10.27 MB / 0.823 GB
Notification: Performance of Transformations before backend: time 0.001201/1.286, allocations: 0 / 1.16 GB, free: 10.27 MB / 0.823 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2045
 * Number of variables: 2045
Notification: Performance of Generate backend data structure: time 0.04437/1.33, allocations: 21.63 MB / 1.181 GB, free: 4.809 MB / 0.8386 GB
Notification: Performance of prepare preOptimizeDAE: time 4.703e-05/1.33, allocations: 8.031 kB / 1.181 GB, free: 4.801 MB / 0.8386 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.002339/1.333, allocations: 1.051 MB / 1.182 GB, free: 3.746 MB / 0.8386 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00907/1.342, allocations: 3.325 MB / 1.185 GB, free: 416 kB / 0.8386 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03577/1.378, allocations: 23.71 MB / 1.209 GB, free: 9.195 MB / 0.8698 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005022/1.378, allocations: 0.6715 MB / 1.209 GB, free: 8.527 MB / 0.8698 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.002853/1.381, allocations: 0.9341 MB / 1.21 GB, free: 7.602 MB / 0.8698 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02628/1.407, allocations: 18.18 MB / 1.228 GB, free: 5.02 MB / 0.8855 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001241/1.407, allocations: 9.25 kB / 1.228 GB, free: 5.016 MB / 0.8855 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001015/1.408, allocations: 328.8 kB / 1.228 GB, free: 4.699 MB / 0.8855 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0002999/1.409, allocations: 370.3 kB / 1.229 GB, free: 4.34 MB / 0.8855 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02603/1.435, allocations: 21.84 MB / 1.25 GB, free: 14.54 MB / 0.9167 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.5768/2.011, allocations: 64.33 MB / 1.313 GB, free: 441.9 MB / 0.9637 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01441/2.026, allocations: 11.69 MB / 1.324 GB, free: 439.5 MB / 0.9637 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.009499/2.035, allocations: 8.966 MB / 1.333 GB, free: 436.2 MB / 0.9637 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.04351/2.079, allocations: 29.66 MB / 1.362 GB, free: 422.1 MB / 0.9637 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01097/2.09, allocations: 11.23 MB / 1.373 GB, free: 417.4 MB / 0.9637 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01635/2.106, allocations: 8.21 MB / 1.381 GB, free: 416.8 MB / 0.9637 GB
Notification: Performance of pre-optimization done (n=567): time 3.162e-05/2.106, allocations: 1.094 kB / 1.381 GB, free: 416.8 MB / 0.9637 GB
Notification: Performance of matching and sorting (n=838): time 0.4725/2.579, allocations: 217.6 MB / 1.593 GB, free: 218.4 MB / 0.9637 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.07187/2.651, allocations: 54.42 MB / 1.646 GB, free: 163.1 MB / 0.9637 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02219/2.673, allocations: 19.97 MB / 1.666 GB, free: 143.3 MB / 0.9637 GB
Notification: Performance of collectPreVariables (initialization): time 0.003426/2.676, allocations: 217.7 kB / 1.666 GB, free: 143.1 MB / 0.9637 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00459/2.681, allocations: 8.203 MB / 1.674 GB, free: 135.3 MB / 0.9637 GB
Notification: Performance of collectInitialBindings (initialization): time 0.006675/2.687, allocations: 3.092 MB / 1.677 GB, free: 132.6 MB / 0.9637 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.006929/2.694, allocations: 3.52 MB / 1.681 GB, free: 129.1 MB / 0.9637 GB
Notification: Performance of setup shared object (initialization): time 3.074e-05/2.694, allocations: 305.1 kB / 1.681 GB, free: 128.8 MB / 0.9637 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01809/2.712, allocations: 19.42 MB / 1.7 GB, free: 109.4 MB / 0.9637 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01996/2.732, allocations: 24.29 MB / 1.724 GB, free: 83.54 MB / 0.9637 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03769/2.77, allocations: 37 MB / 1.76 GB, free: 45.73 MB / 0.9637 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.304e-05/2.77, allocations: 16 kB / 1.76 GB, free: 45.72 MB / 0.9637 GB
Notification: Performance of matching and sorting (n=1355) (initialization): time 0.8212/3.591, allocations: 132.2 MB / 1.889 GB, free: 388.1 MB / 0.9638 GB
Notification: Performance of prepare postOptimizeDAE: time 6.636e-05/3.591, allocations: 51.33 kB / 1.889 GB, free: 388 MB / 0.9638 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.641e-05/3.592, allocations: 51.34 kB / 1.889 GB, free: 388 MB / 0.9638 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2999/3.891, allocations: 117.9 MB / 2.004 GB, free: 288.8 MB / 0.9638 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01019/3.902, allocations: 3.354 MB / 2.007 GB, free: 285.5 MB / 0.9638 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08563/3.987, allocations: 80.98 MB / 2.086 GB, free: 204.5 MB / 0.9638 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04643/4.034, allocations: 6.421 MB / 2.093 GB, free: 198 MB / 0.9638 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004593/4.038, allocations: 1.267 MB / 2.094 GB, free: 196.8 MB / 0.9638 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.02616/4.064, allocations: 22.8 MB / 2.116 GB, free: 173.9 MB / 0.9638 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01929/4.084, allocations: 23.76 MB / 2.139 GB, free: 148.6 MB / 0.9638 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03525/4.119, allocations: 35.96 MB / 2.174 GB, free: 111.9 MB / 0.9638 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.268e-05/4.119, allocations: 16 kB / 2.174 GB, free: 111.9 MB / 0.9638 GB
Notification: Performance of matching and sorting (n=1355) (initialization_lambda0): time 0.6065/4.725, allocations: 130.6 MB / 2.302 GB, free: 383 MB / 0.9638 GB
Notification: Performance of prepare postOptimizeDAE: time 6.671e-05/4.726, allocations: 53.28 kB / 2.302 GB, free: 382.9 MB / 0.9638 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.342e-05/4.726, allocations: 57.34 kB / 2.302 GB, free: 382.9 MB / 0.9638 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3092/5.035, allocations: 117.5 MB / 2.417 GB, free: 345.1 MB / 0.9638 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009075/5.044, allocations: 3.33 MB / 2.42 GB, free: 341.8 MB / 0.9638 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08834/5.132, allocations: 84.25 MB / 2.502 GB, free: 257.8 MB / 0.9638 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04704/5.179, allocations: 6.46 MB / 2.509 GB, free: 251.3 MB / 0.9638 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.003349/5.183, allocations: 1.236 MB / 2.51 GB, free: 250.1 MB / 0.9638 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 233
 * 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 (1035):
 * Single equations (assignments): 1019
 * Array equations: 6
 * Algorithm blocks: 1
 * Record equations: 0
 * 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
   {(28,28,89.3%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 2 systems
   {(5,80), (5,80)}
Notification: Performance of prepare postOptimizeDAE: time 0.003558/5.186, allocations: 0.7214 MB / 2.511 GB, free: 249.4 MB / 0.9638 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005211/5.191, allocations: 1.726 MB / 2.512 GB, free: 248.7 MB / 0.9638 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1104/5.302, allocations: 60.38 MB / 2.571 GB, free: 188.6 MB / 0.9638 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.1216/5.423, allocations: 66.11 MB / 2.636 GB, free: 122.7 MB / 0.9638 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.153e-05/5.423, allocations: 28 kB / 2.636 GB, free: 122.6 MB / 0.9638 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1149/5.538, allocations: 65.43 MB / 2.7 GB, free: 57.36 MB / 0.9638 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.4765/6.015, allocations: 111.4 MB / 2.809 GB, free: 372.2 MB / 0.9638 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.832e-05/6.015, allocations: 2.953 kB / 2.809 GB, free: 372.2 MB / 0.9638 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.006803/6.022, allocations: 1.984 MB / 2.811 GB, free: 372.1 MB / 0.9638 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.1787/6.2, allocations: 81.29 MB / 2.89 GB, free: 339.4 MB / 0.9638 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002955/6.203, allocations: 0.5768 MB / 2.89 GB, free: 338.8 MB / 0.9638 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.06376/6.267, allocations: 57.91 MB / 2.947 GB, free: 280.9 MB / 0.9638 GB
Warning: The linear system: 
1 : valNorth.res1.m_flow + valSouth.res1.m_flow + (-valHea.m_flow) - valCoo.m_flow = 0.0
2 : 0.0 = spl1.res1.m_flow + (-bou.ports[1].m_flow) - valHea.m_flow
3 : valCoo.m_flow + spl1.res1.m_flow + valNorth.res3.m_flow + valSouth.res3.m_flow + (-tabsSouth1[2].m_flow) - tabsSouth1[1].m_flow - tabsSouth1[3].m_flow - tabsSouth1[4].m_flow - tabsSouth2[1].m_flow - tabsSouth2[2].m_flow - tabsSouth2[3].m_flow - tabsSouth2[4].m_flow - tabsSouth2[5].m_flow - tabsSouth2[6].m_flow - tabsSouth2[7].m_flow - tabsSouth2[8].m_flow - tabsNorth1[1].m_flow - tabsNorth1[2].m_flow - tabsNorth1[3].m_flow - tabsNorth1[4].m_flow - tabsNorth2[1].m_flow - tabsNorth2[2].m_flow - tabsNorth2[3].m_flow - tabsNorth2[4].m_flow - tabsNorth2[5].m_flow - tabsNorth2[6].m_flow - tabsNorth2[8].m_flow - tabsNorth2[7].m_flow = 0.0
[
  -1.0 , 0.0 , -1.0 ;
  0.0 , -1.0 , 1.0 ;
  1.0 , 1.0 , 0.0
]
  *
[
  valCoo.m_flow ;
  spl1.res1.m_flow ;
  valHea.m_flow
]
  =
[
  (-valNorth.res1.m_flow) - valSouth.res1.m_flow ;
  -bou.ports[1].m_flow ;
  tabsSouth1[2].m_flow + tabsNorth2[8].m_flow + tabsNorth2[7].m_flow + tabsNorth2[6].m_flow + tabsNorth2[5].m_flow + tabsNorth2[4].m_flow + tabsNorth2[3].m_flow + tabsNorth2[2].m_flow + tabsNorth2[1].m_flow + tabsNorth1[4].m_flow + tabsNorth1[3].m_flow + tabsNorth1[2].m_flow + tabsNorth1[1].m_flow + tabsSouth2[8].m_flow + tabsSouth2[7].m_flow + tabsSouth2[6].m_flow + tabsSouth2[5].m_flow + tabsSouth2[4].m_flow + tabsSouth2[3].m_flow + tabsSouth2[2].m_flow + tabsSouth2[1].m_flow + tabsSouth1[4].m_flow + tabsSouth1[3].m_flow + tabsSouth1[1].m_flow + (-valSouth.res3.m_flow) - valNorth.res3.m_flow
]
 might be structurally or numerically singular for variable valHea.m_flow since U(3,3) = 0.0. It might be hard to solve. Compilation continues anyway.
Warning: The linear system: 
1 : valCoo.m_flow + spl1.res1.m_flow + valNorth.res3.m_flow + valSouth.res3.m_flow + (-tabsSouth1[2].m_flow) - tabsSouth1[1].m_flow - tabsSouth1[3].m_flow - tabsSouth1[4].m_flow - tabsSouth2[1].m_flow - tabsSouth2[2].m_flow - tabsSouth2[3].m_flow - tabsSouth2[4].m_flow - tabsSouth2[5].m_flow - tabsSouth2[6].m_flow - tabsSouth2[7].m_flow - tabsSouth2[8].m_flow - tabsNorth1[1].m_flow - tabsNorth1[2].m_flow - tabsNorth1[3].m_flow - tabsNorth1[4].m_flow - tabsNorth2[1].m_flow - tabsNorth2[2].m_flow - tabsNorth2[3].m_flow - tabsNorth2[4].m_flow - tabsNorth2[5].m_flow - tabsNorth2[6].m_flow - tabsNorth2[8].m_flow - tabsNorth2[7].m_flow = 0.0
2 : 0.0 = spl1.res1.m_flow + (-bou.ports[1].m_flow) - valHea.m_flow
3 : valNorth.res1.m_flow + valSouth.res1.m_flow + (-valHea.m_flow) - valCoo.m_flow = 0.0
[
  1.0 , 0.0 , 1.0 ;
  0.0 , 1.0 , -1.0 ;
  -1.0 , -1.0 , 0.0
]
  *
[
  valCoo.m_flow ;
  valHea.m_flow ;
  spl1.res1.m_flow
]
  =
[
  tabsSouth1[2].m_flow + tabsNorth2[8].m_flow + tabsNorth2[7].m_flow + tabsNorth2[6].m_flow + tabsNorth2[5].m_flow + tabsNorth2[4].m_flow + tabsNorth2[3].m_flow + tabsNorth2[2].m_flow + tabsNorth2[1].m_flow + tabsNorth1[4].m_flow + tabsNorth1[3].m_flow + tabsNorth1[2].m_flow + tabsNorth1[1].m_flow + tabsSouth2[8].m_flow + tabsSouth2[7].m_flow + tabsSouth2[6].m_flow + tabsSouth2[5].m_flow + tabsSouth2[4].m_flow + tabsSouth2[3].m_flow + tabsSouth2[2].m_flow + tabsSouth2[1].m_flow + tabsSouth1[4].m_flow + tabsSouth1[3].m_flow + tabsSouth1[1].m_flow + (-valSouth.res3.m_flow) - valNorth.res3.m_flow ;
  -bou.ports[1].m_flow ;
  (-valNorth.res1.m_flow) - valSouth.res1.m_flow
]
 might be structurally or numerically singular for variable spl1.res1.m_flow since U(3,3) = 0.0. It might be hard to solve. Compilation continues anyway.
Warning: The linear system: 
1 : valCoo.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + spl1.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + valNorth.res3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + valSouth.res3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + (-tabsNorth2.8.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - tabsNorth2.7.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth2.6.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth2.5.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth2.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth2.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth2.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth2.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth1.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth1.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth1.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsNorth1.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.8.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.7.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.6.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.5.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth2.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth1.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth1.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth1.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 - tabsSouth1.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 = 0.0
2 : valNorth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + valSouth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + (-valHea.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - valCoo.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 = 0.0
3 : 0.0 = spl1.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + (-bou.ports.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - valHea.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24
[
  1.0 , 0.0 , 1.0 ;
  0.0 , -1.0 , -1.0 ;
  -1.0 , 1.0 , 0.0
]
  *
[
  spl1.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 ;
  valHea.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 ;
  valCoo.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24
]
  =
[
  tabsNorth2.8.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth1.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth1.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth1.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth1.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.5.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.6.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.7.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsSouth2.8.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth1.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth1.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth1.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth1.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth2.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth2.2.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth2.3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth2.4.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth2.5.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth2.6.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + tabsNorth2.7.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + (-valSouth.res3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - valNorth.res3.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 ;
  (-valNorth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - valSouth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 ;
  -bou.ports.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24
]
 might be structurally or numerically singular for variable valCoo.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 since U(3,3) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 0.05829/6.325, allocations: 52 MB / 2.998 GB, free: 228.4 MB / 0.9638 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1426/6.468, allocations: 95.41 MB / 3.091 GB, free: 134.1 MB / 0.9638 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01427/6.482, allocations: 6.201 MB / 3.097 GB, free: 128.9 MB / 0.9638 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.006592/6.489, allocations: 216.5 kB / 3.097 GB, free: 128.7 MB / 0.9638 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02832/6.517, allocations: 3.317 MB / 3.1 GB, free: 125.4 MB / 0.9638 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.003658/6.521, allocations: 0.8924 MB / 3.101 GB, free: 124.5 MB / 0.9638 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001258/6.522, allocations: 0.6315 MB / 3.102 GB, free: 123.9 MB / 0.9638 GB
Notification: Performance of sorting global known variables: time 0.01317/6.535, allocations: 14 MB / 3.116 GB, free: 110 MB / 0.9638 GB
Notification: Performance of sort global known variables: time 1.9e-07/6.535, allocations: 0 / 3.116 GB, free: 110 MB / 0.9638 GB
Notification: Performance of remove unused functions: time 0.05524/6.59, allocations: 38.38 MB / 3.153 GB, free: 71.74 MB / 0.9638 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 74 ($STATESET1.x[31],$STATESET1.x[30],$STATESET1.x[29],$STATESET1.x[28],$STATESET1.x[27],$STATESET1.x[26],$STATESET1.x[25],$STATESET1.x[24],$STATESET1.x[23],$STATESET1.x[22],$STATESET1.x[21],$STATESET1.x[20],$STATESET1.x[19],$STATESET1.x[18],$STATESET1.x[17],$STATESET1.x[16],$STATESET1.x[15],$STATESET1.x[14],$STATESET1.x[13],$STATESET1.x[12],$STATESET1.x[11],$STATESET1.x[10],$STATESET1.x[9],$STATESET1.x[8],$STATESET1.x[7],$STATESET1.x[6],$STATESET1.x[5],$STATESET1.x[4],$STATESET1.x[3],$STATESET1.x[2],$STATESET1.x[1],pmpSouth.vol.dynBal.U,pmpSouth.filter.s[1],pmpNorth.vol.dynBal.U,pmpNorth.filter.s[1],valSouth1[1].filter.s[1],valSouth1[2].filter.s[1],valSouth1[3].filter.s[1],valSouth1[4].filter.s[1],valSouth2[1].filter.s[1],valSouth2[2].filter.s[1],valSouth2[3].filter.s[1],valSouth2[4].filter.s[1],valSouth2[5].filter.s[1],valSouth2[6].filter.s[1],valSouth2[7].filter.s[1],valSouth2[8].filter.s[1],valNorth1[1].filter.s[1],valNorth1[2].filter.s[1],valNorth1[3].filter.s[1],valNorth1[4].filter.s[1],valNorth2[1].filter.s[1],valNorth2[2].filter.s[1],valNorth2[3].filter.s[1],valNorth2[4].filter.s[1],valNorth2[5].filter.s[1],valNorth2[6].filter.s[1],valNorth2[7].filter.s[1],valNorth2[8].filter.s[1],valSouth.vol.dynBal.U,valSouth.filter.s[1],valNorth.vol.dynBal.U,valNorth.filter.s[1],spl.vol.dynBal.U,spl1.vol.dynBal.U,pumpHea.vol.dynBal.U,pumpHea.filter.s[1],valHea.filter.s[1],valCoo.filter.s[1],spl2.vol.dynBal.U,spl3.vol.dynBal.U,pumpCoo.vol.dynBal.U,pumpCoo.filter.s[1],vol.p)
 * Number of discrete variables: 7 ($whenCondition2,$whenCondition1,stepPump.y,stepPump.pulseStart,pumpHea.stage,stepValve.T_start,stepValve.count)
 * Number of discrete states: 1 (stepValve.count)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (621):
 * Single equations (assignments): 600
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 10
 * When equations: 3
 * If-equations: 0
 * Equation systems (not torn): 4
 * 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): 4 systems
   {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
   {(28,28,89.3%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 3 systems
   {(7,83), (1,1), (38,197)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.4552/7.046, allocations: 96.74 MB / 3.248 GB, free: 387.8 MB / 0.9638 GB
Notification: Performance of simCode: created initialization part: time 0.08775/7.133, allocations: 71.92 MB / 3.318 GB, free: 366.3 MB / 0.9638 GB
Notification: Performance of simCode: created event and clocks part: time 1.076e-05/7.133, allocations: 6.531 kB / 3.318 GB, free: 366.3 MB / 0.9638 GB
Notification: Performance of simCode: created simulation system equations: time 0.03085/7.164, allocations: 23.17 MB / 3.34 GB, free: 359.1 MB / 0.9638 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.03313/7.197, allocations: 8.444 MB / 3.349 GB, free: 353.1 MB / 0.9638 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 1.155/8.352, allocations: 430.7 MB / 3.769 GB, free: 361.5 MB / 0.9638 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.00756/8.36, allocations: 10.24 MB / 3.779 GB, free: 357.4 MB / 0.9638 GB
Notification: Performance of simCode: alias equations: time 0.02095/8.381, allocations: 7.892 MB / 3.787 GB, free: 355.1 MB / 0.9638 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01438/8.395, allocations: 10.42 MB / 3.797 GB, free: 351 MB / 0.9638 GB
Notification: Performance of SimCode: time 1.042e-06/8.395, allocations: 0.75 kB / 3.797 GB, free: 351 MB / 0.9638 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.483/9.878, allocations: 0.8476 GB / 4.645 GB, free: 363.8 MB / 0.9638 GB
Notification: Performance of buildModelFMU: Generate platform static: time 60.05/69.92, allocations: 10.75 kB / 4.645 GB, free: 363.8 MB / 0.9638 GB
"
[Timeout remaining time 590]
(rm -f BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3.pipe ; mkfifo BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3.pipe ; head -c 1048576 < BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3.pipe >> ../files/BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3.sim & python3 -m fmpy simulate  --output-file BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3_res.csv --start-time 0 --stop-time 1000 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 0.4 BuildSysPro_BuildSysPro_IBPSA_Fluid_Examples_FlowSystem_Simplified3.fmu > BuildSysPro_BuildSysPro.IBPSA.Fluid.Examples.FlowSystem.Simplified3.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 72.94580871798098]
Failed to read output from testmodel.py, exit status != 0:
70.30497511662543 70.313904607 69.027362714
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x70ed16559730>