Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr IDEAS_dev_IDEAS.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.0008177/0.0008177, allocations: 109.9 kB / 18.93 MB, free: 1.27 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.000904/0.000904, allocations: 222.3 kB / 22.26 MB, free: 3.688 MB / 13.93 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.9415/0.9415, allocations: 230.6 MB / 256 MB, free: 9.801 MB / 202.7 MB
"
[Timeout remaining time 179]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo", uses=false) [Timeout 180]
"[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-531:190:writable] Warning: Lexer treating \\ as \\\\, since \\e is not a valid Modelica escape sequence.
[/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/Examples/PPD12/Structure.mo:531:21-531:198:writable] Warning: Lexer treating \\ as \\\\, since \\< is not a valid Modelica escape sequence.
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/package.mo): time 0.7998/0.7998, allocations: 203.8 MB / 0.5042 GB, free: 10.73 MB / 410.7 MB
"
[Timeout remaining time 179]
Using package IDEAS with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/IDEAS master/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(IDEAS.Fluid.Examples.FlowSystem.Simplified3,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Examples_FlowSystem_Simplified3",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(IDEAS.Fluid.Examples.FlowSystem.Simplified3,fileNamePrefix="IDEAS_dev_IDEAS_Fluid_Examples_FlowSystem_Simplified3",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: IDEAS requested package Modelica of version 4.0.0. Modelica 4.1.0 is used instead which states that it is fully compatible without conversion script needed.
Notification: Performance of FrontEnd - loaded program: time 0.0008896/0.0008896, allocations: 70.48 kB / 0.7183 GB, free: 4.266 MB / 0.5261 GB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.4568/0.4576, allocations: 102 MB / 0.8179 GB, free: 1.27 MB / 0.6042 GB
Notification: Performance of NFInst.instantiate(IDEAS.Fluid.Examples.FlowSystem.Simplified3): time 0.6876/1.145, allocations: 365.3 MB / 1.175 GB, free: 61.94 MB / 0.9167 GB
Notification: Performance of NFInst.instExpressions: time 0.07804/1.223, allocations: 76.23 MB / 1.249 GB, free: 60.85 MB / 0.9167 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01789/1.241, allocations: 0.5996 MB / 1.25 GB, free: 60.85 MB / 0.9167 GB
Notification: Performance of NFTyping.typeComponents: time 0.02165/1.263, allocations: 6.702 MB / 1.256 GB, free: 60.73 MB / 0.9167 GB
Notification: Performance of NFTyping.typeBindings: time 0.03736/1.3, allocations: 14.97 MB / 1.271 GB, free: 58.95 MB / 0.9167 GB
Notification: Performance of NFTyping.typeClassSections: time 0.02101/1.321, allocations: 10.63 MB / 1.281 GB, free: 52.6 MB / 0.9167 GB
Notification: Performance of NFFlatten.flatten: time 0.05353/1.375, allocations: 56.22 MB / 1.336 GB, free: 8.535 MB / 0.9167 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0201/1.395, allocations: 15.43 MB / 1.351 GB, free: 9.715 MB / 0.9323 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.03956/1.434, allocations: 17.72 MB / 1.369 GB, free: 8.953 MB / 0.948 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.02665/1.461, allocations: 16.28 MB / 1.384 GB, free: 9.777 MB / 0.9636 GB
Notification: Performance of NFPackage.collectConstants: time 0.008855/1.47, allocations: 1.867 MB / 1.386 GB, free: 7.91 MB / 0.9636 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02431/1.494, allocations: 6.32 MB / 1.392 GB, free: 1.867 MB / 0.9636 GB
Notification: Performance of NFScalarize.scalarize: time 0.01043/1.505, allocations: 6.269 MB / 1.399 GB, free: 11.83 MB / 0.9792 GB
Notification: Performance of NFVerifyModel.verify: time 0.02156/1.526, allocations: 10.86 MB / 1.409 GB, free: 1.164 MB / 0.9792 GB
Notification: Performance of NFConvertDAE.convert: time 0.04115/1.567, allocations: 30.44 MB / 1.439 GB, free: 3.883 MB / 1.01 GB
Notification: Performance of FrontEnd - DAE generated: time 6.122e-06/1.567, allocations: 0 / 1.439 GB, free: 3.883 MB / 1.01 GB
Notification: Performance of FrontEnd: time 2.074e-06/1.567, allocations: 0 / 1.439 GB, free: 3.883 MB / 1.01 GB
Notification: Performance of Transformations before backend: time 0.0009675/1.568, allocations: 0 / 1.439 GB, free: 3.883 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: 1949
 * Number of variables: 1949
Notification: Performance of Generate backend data structure: time 0.04239/1.611, allocations: 21.03 MB / 1.459 GB, free: 14.94 MB / 1.042 GB
Notification: Performance of prepare preOptimizeDAE: time 5.584e-05/1.611, allocations: 9.109 kB / 1.459 GB, free: 14.93 MB / 1.042 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001674/1.612, allocations: 1.006 MB / 1.46 GB, free: 13.91 MB / 1.042 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.00912/1.622, allocations: 3.216 MB / 1.464 GB, free: 10.68 MB / 1.042 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.03547/1.657, allocations: 22.5 MB / 1.486 GB, free: 4.461 MB / 1.057 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0005038/1.658, allocations: 0.6463 MB / 1.486 GB, free: 3.816 MB / 1.057 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003474/1.661, allocations: 0.8775 MB / 1.487 GB, free: 2.941 MB / 1.057 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02334/1.684, allocations: 17.12 MB / 1.504 GB, free: 1.598 MB / 1.073 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001102/1.684, allocations: 11.88 kB / 1.504 GB, free: 1.586 MB / 1.073 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008849/1.685, allocations: 322.9 kB / 1.504 GB, free: 1.273 MB / 1.073 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0001192/1.685, allocations: 204 kB / 1.504 GB, free: 1.074 MB / 1.073 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0246/1.71, allocations: 21.39 MB / 1.525 GB, free: 11.66 MB / 1.104 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.5313/2.241, allocations: 81.72 MB / 1.605 GB, free: 458.6 MB / 1.135 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01442/2.256, allocations: 12.33 MB / 1.617 GB, free: 454.2 MB / 1.135 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.008898/2.265, allocations: 9.199 MB / 1.626 GB, free: 449.8 MB / 1.135 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.03567/2.3, allocations: 31.89 MB / 1.657 GB, free: 428 MB / 1.135 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.009005/2.309, allocations: 10.49 MB / 1.667 GB, free: 421.7 MB / 1.135 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.01592/2.325, allocations: 8.223 MB / 1.675 GB, free: 419.6 MB / 1.135 GB
Notification: Performance of pre-optimization done (n=503): time 2.285e-05/2.325, allocations: 0 / 1.675 GB, free: 419.6 MB / 1.135 GB
Notification: Performance of matching and sorting (n=742): time 0.4725/2.798, allocations: 218 MB / 1.888 GB, free: 203.1 MB / 1.135 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.05999/2.858, allocations: 48.72 MB / 1.936 GB, free: 153.4 MB / 1.135 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.02038/2.878, allocations: 19.74 MB / 1.955 GB, free: 133.8 MB / 1.135 GB
Notification: Performance of collectPreVariables (initialization): time 0.0034/2.882, allocations: 209.7 kB / 1.955 GB, free: 133.6 MB / 1.135 GB
Notification: Performance of collectInitialEqns (initialization): time 0.003892/2.886, allocations: 7.656 MB / 1.963 GB, free: 125.9 MB / 1.135 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004748/2.89, allocations: 2.762 MB / 1.965 GB, free: 123.2 MB / 1.135 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004494/2.895, allocations: 3.789 MB / 1.969 GB, free: 119.4 MB / 1.135 GB
Notification: Performance of setup shared object (initialization): time 2.36e-05/2.895, allocations: 305.1 kB / 1.969 GB, free: 119.1 MB / 1.135 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01712/2.912, allocations: 19.45 MB / 1.988 GB, free: 99.63 MB / 1.135 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01904/2.931, allocations: 22.22 MB / 2.01 GB, free: 76.39 MB / 1.135 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.03738/2.968, allocations: 37.35 MB / 2.047 GB, free: 38.27 MB / 1.135 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.465e-05/2.968, allocations: 16 kB / 2.047 GB, free: 38.25 MB / 1.135 GB
Notification: Performance of matching and sorting (n=1491) (initialization): time 0.8257/3.794, allocations: 132.2 MB / 2.176 GB, free: 416.2 MB / 1.135 GB
Notification: Performance of prepare postOptimizeDAE: time 6.625e-05/3.794, allocations: 57.48 kB / 2.176 GB, free: 416.2 MB / 1.135 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 6.105e-05/3.794, allocations: 52.31 kB / 2.176 GB, free: 416.2 MB / 1.135 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.2927/4.087, allocations: 118 MB / 2.291 GB, free: 309 MB / 1.135 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.00962/4.097, allocations: 3.174 MB / 2.294 GB, free: 305.9 MB / 1.135 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.08731/4.184, allocations: 81.75 MB / 2.374 GB, free: 224.1 MB / 1.135 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04877/4.233, allocations: 6.578 MB / 2.38 GB, free: 217.5 MB / 1.135 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.007661/4.24, allocations: 1.302 MB / 2.382 GB, free: 216.2 MB / 1.135 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.03004/4.27, allocations: 22.55 MB / 2.404 GB, free: 193.6 MB / 1.135 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.02338/4.294, allocations: 21.7 MB / 2.425 GB, free: 170.9 MB / 1.135 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.03801/4.332, allocations: 36.31 MB / 2.46 GB, free: 133.9 MB / 1.135 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.084e-05/4.332, allocations: 16 kB / 2.46 GB, free: 133.8 MB / 1.135 GB
Notification: Performance of matching and sorting (n=1491) (initialization_lambda0): time 0.7958/5.128, allocations: 130.7 MB / 2.588 GB, free: 417.8 MB / 1.135 GB
Notification: Performance of prepare postOptimizeDAE: time 0.0001019/5.128, allocations: 53.8 kB / 2.588 GB, free: 417.8 MB / 1.135 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 8.356e-05/5.128, allocations: 52.66 kB / 2.588 GB, free: 417.8 MB / 1.135 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.3036/5.431, allocations: 117.6 MB / 2.703 GB, free: 387.7 MB / 1.135 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01034/5.442, allocations: 3.15 MB / 2.706 GB, free: 384.7 MB / 1.135 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.09323/5.535, allocations: 85.89 MB / 2.79 GB, free: 298.8 MB / 1.135 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.04676/5.582, allocations: 6.634 MB / 2.796 GB, free: 292.2 MB / 1.135 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.004937/5.587, allocations: 1.271 MB / 2.798 GB, free: 290.9 MB / 1.135 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 237
 * 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 (1043):
 * Single equations (assignments): 1023
 * Array equations: 6
 * 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
   {(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.00408/5.591, allocations: 0.7096 MB / 2.798 GB, free: 290.3 MB / 1.135 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.005167/5.596, allocations: 1.624 MB / 2.8 GB, free: 289.6 MB / 1.135 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.1057/5.702, allocations: 59.97 MB / 2.858 GB, free: 229.9 MB / 1.135 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.1118/5.813, allocations: 63.67 MB / 2.921 GB, free: 166.2 MB / 1.135 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 6.182e-05/5.813, allocations: 35.53 kB / 2.921 GB, free: 166.2 MB / 1.135 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.1074/5.921, allocations: 62.98 MB / 2.982 GB, free: 103.2 MB / 1.135 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.6348/6.556, allocations: 127.3 MB / 3.107 GB, free: 410.6 MB / 1.135 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.212e-05/6.556, allocations: 0 / 3.107 GB, free: 410.6 MB / 1.135 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.006797/6.563, allocations: 2.129 MB / 3.109 GB, free: 410.6 MB / 1.135 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.1682/6.731, allocations: 78.42 MB / 3.185 GB, free: 389.4 MB / 1.135 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002871/6.734, allocations: 0.5334 MB / 3.186 GB, free: 389 MB / 1.135 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.05988/6.793, allocations: 55.53 MB / 3.24 GB, free: 339.9 MB / 1.135 GB
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 + 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 : valNorth.res1.m_flow + valSouth.res1.m_flow + (-valHea.m_flow) - valCoo.m_flow = 0.0
3 : 0.0 = spl1.res1.m_flow + (-bou.ports[1].m_flow) - valHea.m_flow
[
  1.0 , 0.0 , 1.0 ;
  0.0 , -1.0 , -1.0 ;
  -1.0 , 1.0 , 0.0
]
  *
[
  spl1.res1.m_flow ;
  valHea.m_flow ;
  valCoo.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 ;
  (-valNorth.res1.m_flow) - valSouth.res1.m_flow ;
  -bou.ports[1].m_flow
]
 might be structurally or numerically singular for variable valCoo.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.
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 : 0.0 = spl1.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + (-bou.ports.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - valHea.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24
3 : valNorth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + valSouth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 + (-valHea.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - valCoo.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 = 0.0
[
  1.0 , 0.0 , 1.0 ;
  0.0 , 1.0 , -1.0 ;
  -1.0 , -1.0 , 0.0
]
  *
[
  valCoo.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 ;
  valHea.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 ;
  spl1.res1.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 ;
  -bou.ports.1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24 ;
  (-valNorth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24) - valSouth.res1.m_flow.$pDERStateSetJac24.dummyVarStateSetJac24
]
 might be structurally or numerically singular for variable spl1.res1.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.051/6.844, allocations: 47.63 MB / 3.286 GB, free: 291.5 MB / 1.135 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.1348/6.979, allocations: 90.7 MB / 3.375 GB, free: 201.7 MB / 1.135 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.01262/6.992, allocations: 5.576 MB / 3.38 GB, free: 197 MB / 1.135 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.004287/6.996, allocations: 164 kB / 3.381 GB, free: 196.9 MB / 1.135 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.02564/7.022, allocations: 3.481 MB / 3.384 GB, free: 193.4 MB / 1.135 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002676/7.024, allocations: 0.8488 MB / 3.385 GB, free: 192.5 MB / 1.135 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001255/7.026, allocations: 0.6158 MB / 3.385 GB, free: 191.9 MB / 1.135 GB
Notification: Performance of sorting global known variables: time 0.01458/7.04, allocations: 13.76 MB / 3.399 GB, free: 178.2 MB / 1.135 GB
Notification: Performance of sort global known variables: time 8e-08/7.04, allocations: 0 / 3.399 GB, free: 178.2 MB / 1.135 GB
Notification: Performance of remove unused functions: time 0.05639/7.097, allocations: 34.92 MB / 3.433 GB, free: 143.3 MB / 1.135 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 5
 * Number of states: 42 ($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,pmpNorth.vol.dynBal.U,valSouth.vol.dynBal.U,valNorth.vol.dynBal.U,spl.vol.dynBal.U,spl1.vol.dynBal.U,pumpHea.vol.dynBal.U,spl2.vol.dynBal.U,spl3.vol.dynBal.U,pumpCoo.vol.dynBal.U,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 (556):
 * Single equations (assignments): 535
 * 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,166)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.1392/7.236, allocations: 92.27 MB / 3.523 GB, free: 51.33 MB / 1.135 GB
Notification: Performance of simCode: created initialization part: time 0.5206/7.756, allocations: 69.46 MB / 3.591 GB, free: 442.3 MB / 1.135 GB
Notification: Performance of simCode: created event and clocks part: time 2.05e-05/7.756, allocations: 2.438 kB / 3.591 GB, free: 442.3 MB / 1.135 GB
Notification: Performance of simCode: created simulation system equations: time 0.03883/7.795, allocations: 22.11 MB / 3.613 GB, free: 439.2 MB / 1.135 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.04106/7.836, allocations: 8.1 MB / 3.62 GB, free: 437.2 MB / 1.135 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.8621/8.698, allocations: 424.5 MB / 4.035 GB, free: 52.73 MB / 1.135 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01166/8.71, allocations: 9.91 MB / 4.045 GB, free: 42.77 MB / 1.135 GB
Notification: Performance of simCode: alias equations: time 0.02325/8.733, allocations: 6.808 MB / 4.051 GB, free: 35.95 MB / 1.135 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.01591/8.749, allocations: 10.05 MB / 4.061 GB, free: 25.9 MB / 1.135 GB
Notification: Performance of SimCode: time 2.575e-06/8.749, allocations: 0 / 4.061 GB, free: 25.9 MB / 1.135 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 1.911/10.66, allocations: 0.7998 GB / 4.861 GB, free: 175.3 MB / 1.136 GB
Notification: Performance of buildModelFMU: Generate platform static: time 61.02/71.69, allocations: 18.78 kB / 4.861 GB, free: 175.2 MB / 1.136 GB
"
[Timeout remaining time 588]
(rm -f IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified3.pipe ; mkfifo IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified3.pipe ; head -c 1048576 < IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified3.pipe >> ../files/IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified3.sim & python3 -m fmpy simulate  --output-file IDEAS_dev_IDEAS.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 IDEAS_dev_IDEAS_Fluid_Examples_FlowSystem_Simplified3.fmu > IDEAS_dev_IDEAS.Fluid.Examples.FlowSystem.Simplified3.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 74.96603685780428]
Failed to read output from testmodel.py, exit status != 0:
72.02703786198981 72.036733787 70.467462271
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x78e1706b52e0>