Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.0.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.0007816/0.0007816, allocations: 76.08 kB / 20.67 MB, free: 3.891 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.0007296/0.0007296, allocations: 153.1 kB / 23.93 MB, free: 0.6328 MB / 18.57 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 0.8751/0.8751, allocations: 173.4 MB / 200.4 MB, free: 9.43 MB / 186.7 MB
"
[Timeout remaining time 179]
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: "" <> buildModelFMU(Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater,fileNamePrefix="Modelica_4_0_0_Modelica_Fluid_Examples_AST_BatchPlant_BatchPlant_StandardWater",fmuType="me",version="2.0",platforms={"static"})
"" <> buildModelFMU(Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater,fileNamePrefix="Modelica_4_0_0_Modelica_Fluid_Examples_AST_BatchPlant_BatchPlant_StandardWater",fmuType="me",version="2.0",platforms={"static"}) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 1.543e-06/1.543e-06, allocations: 0 / 318.5 MB, free: 6.195 MB / 282.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 1.234e-05/1.389e-05, allocations: 6.219 kB / 318.5 MB, free: 6.188 MB / 282.7 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater): time 0.6758/0.6758, allocations: 385.4 MB / 0.6874 GB, free: 184 kB / 0.5105 GB
Notification: Performance of NFInst.instExpressions: time 0.069/0.7448, allocations: 85.25 MB / 0.7706 GB, free: 1.215 MB / 0.5261 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.009147/0.7539, allocations: 314.3 kB / 0.7709 GB, free: 0.9883 MB / 0.5261 GB
Notification: Performance of NFTyping.typeComponents: time 0.009737/0.7637, allocations: 4.411 MB / 0.7753 GB, free: 12.55 MB / 0.5417 GB
Notification: Performance of NFTyping.typeBindings: time 0.04644/0.8101, allocations: 21.22 MB / 0.796 GB, free: 7.23 MB / 0.5573 GB
Notification: Performance of NFTyping.typeClassSections: time 0.03622/0.8463, allocations: 19.39 MB / 0.8149 GB, free: 3.836 MB / 0.573 GB
Notification: Performance of NFFlatten.flatten: time 0.02799/0.8743, allocations: 25.97 MB / 0.8403 GB, free: 9.785 MB / 0.6042 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.009043/0.8834, allocations: 6.741 MB / 0.8469 GB, free: 2.961 MB / 0.6042 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01475/0.8981, allocations: 12.93 MB / 0.8595 GB, free: 6 MB / 0.6198 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.3554/1.254, allocations: 37.78 MB / 0.8964 GB, free: 38.16 MB / 0.6355 GB
Notification: Performance of NFPackage.collectConstants: time 0.004782/1.258, allocations: 1.194 MB / 0.8975 GB, free: 38.16 MB / 0.6355 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.02958/1.288, allocations: 15.49 MB / 0.9127 GB, free: 38.13 MB / 0.6355 GB
Notification: Performance of NFScalarize.scalarize: time 0.006018/1.294, allocations: 3.913 MB / 0.9165 GB, free: 38.13 MB / 0.6355 GB
Notification: Performance of NFVerifyModel.verify: time 0.008122/1.302, allocations: 4.551 MB / 0.9209 GB, free: 38.13 MB / 0.6355 GB
Notification: Performance of NFConvertDAE.convert: time 0.03925/1.341, allocations: 28.83 MB / 0.9491 GB, free: 37.13 MB / 0.6355 GB
Notification: Performance of FrontEnd - DAE generated: time 5.912e-06/1.341, allocations: 4 kB / 0.9491 GB, free: 37.12 MB / 0.6355 GB
Notification: Performance of FrontEnd: time 1.733e-06/1.341, allocations: 0 / 0.9491 GB, free: 37.12 MB / 0.6355 GB
Notification: Performance of Transformations before backend: time 0.00028/1.342, allocations: 0 / 0.9491 GB, free: 37.12 MB / 0.6355 GB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2389
 * Number of variables: 2389
Notification: Performance of Generate backend data structure: time 0.02408/1.366, allocations: 16.92 MB / 0.9656 GB, free: 29.55 MB / 0.6355 GB
Notification: Performance of prepare preOptimizeDAE: time 4.159e-05/1.366, allocations: 8.391 kB / 0.9656 GB, free: 29.55 MB / 0.6355 GB
Notification: Performance of preOpt introduceOutputAliases (simulation): time 0.001171/1.367, allocations: 1.232 MB / 0.9668 GB, free: 29.45 MB / 0.6355 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01206/1.379, allocations: 3.401 MB / 0.9702 GB, free: 28.81 MB / 0.6355 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01656/1.395, allocations: 11.02 MB / 0.9809 GB, free: 26.66 MB / 0.6355 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008757/1.396, allocations: 1.704 MB / 0.9826 GB, free: 25.57 MB / 0.6355 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001804/1.398, allocations: 0.9332 MB / 0.9835 GB, free: 25.56 MB / 0.6355 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.0205/1.419, allocations: 16.54 MB / 0.9996 GB, free: 15.09 MB / 0.6355 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001607/1.419, allocations: 35.7 kB / 0.9997 GB, free: 15.07 MB / 0.6355 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.0008419/1.42, allocations: 393.8 kB / 1 GB, free: 14.97 MB / 0.6355 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0003871/1.42, allocations: 0.5847 MB / 1.001 GB, free: 14.43 MB / 0.6355 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.0198/1.44, allocations: 13.82 MB / 1.014 GB, free: 4.777 MB / 0.6355 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.05459/1.494, allocations: 43.92 MB / 1.057 GB, free: 9.219 MB / 0.6823 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.01561/1.51, allocations: 11.29 MB / 1.068 GB, free: 13.9 MB / 0.698 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.006681/1.517, allocations: 5.236 MB / 1.073 GB, free: 8.629 MB / 0.698 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.05802/1.575, allocations: 34.01 MB / 1.106 GB, free: 6.645 MB / 0.7292 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.01628/1.591, allocations: 8.766 MB / 1.115 GB, free: 13.64 MB / 0.7448 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.003262/1.594, allocations: 0.8844 MB / 1.116 GB, free: 12.77 MB / 0.7448 GB
Notification: Performance of pre-optimization done (n=925): time 2.146e-05/1.594, allocations: 0 / 1.116 GB, free: 12.77 MB / 0.7448 GB
Notification: Performance of matching and sorting (n=999): time 0.2831/1.877, allocations: 63.06 MB / 1.177 GB, free: 441.3 MB / 0.7761 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001941/1.878, allocations: 0.6221 MB / 1.178 GB, free: 440.7 MB / 0.7761 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005002/1.883, allocations: 5.6 MB / 1.183 GB, free: 440 MB / 0.7761 GB
Notification: Performance of collectPreVariables (initialization): time 0.001512/1.884, allocations: 301.6 kB / 1.184 GB, free: 439.8 MB / 0.7761 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00182/1.886, allocations: 3.895 MB / 1.188 GB, free: 437.2 MB / 0.7761 GB
Notification: Performance of collectInitialBindings (initialization): time 0.002016/1.888, allocations: 3.267 MB / 1.191 GB, free: 435 MB / 0.7761 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.00233/1.89, allocations: 2.259 MB / 1.193 GB, free: 434.1 MB / 0.7761 GB
Notification: Performance of setup shared object (initialization): time 2.885e-05/1.89, allocations: 304.1 kB / 1.193 GB, free: 433.8 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00605/1.896, allocations: 4.998 MB / 1.198 GB, free: 432 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007106/1.903, allocations: 7.33 MB / 1.205 GB, free: 427.6 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01251/1.916, allocations: 11.91 MB / 1.217 GB, free: 421 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 3.822e-05/1.916, allocations: 17.78 kB / 1.217 GB, free: 421 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=1456) (initialization): time 0.0196/1.936, allocations: 15.24 MB / 1.232 GB, free: 412.2 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 4.685e-05/1.936, allocations: 29.09 kB / 1.232 GB, free: 412.2 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 5.832e-05/1.936, allocations: 67.52 kB / 1.232 GB, free: 412.1 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.005485/1.941, allocations: 3.253 MB / 1.235 GB, free: 409.5 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.005036/1.946, allocations: 2.288 MB / 1.237 GB, free: 407.6 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01026/1.956, allocations: 25.23 MB / 1.262 GB, free: 382.4 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.00557/1.962, allocations: 0.5367 MB / 1.262 GB, free: 382 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0008488/1.963, allocations: 0.5173 MB / 1.263 GB, free: 381.5 MB / 0.7761 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.008716/1.972, allocations: 6.437 MB / 1.269 GB, free: 376 MB / 0.7761 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.006215/1.978, allocations: 7.248 MB / 1.276 GB, free: 368.7 MB / 0.7761 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01154/1.989, allocations: 11.72 MB / 1.288 GB, free: 357 MB / 0.7761 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 3.558e-05/1.989, allocations: 22 kB / 1.288 GB, free: 356.9 MB / 0.7761 GB
Notification: Performance of matching and sorting (n=1456) (initialization_lambda0): time 0.01792/2.007, allocations: 14.97 MB / 1.302 GB, free: 341.9 MB / 0.7761 GB
Notification: Performance of prepare postOptimizeDAE: time 3.874e-05/2.007, allocations: 28 kB / 1.302 GB, free: 341.9 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 4.941e-05/2.007, allocations: 64 kB / 1.303 GB, free: 341.8 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.003725/2.011, allocations: 2.447 MB / 1.305 GB, free: 339.3 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.004621/2.016, allocations: 2.326 MB / 1.307 GB, free: 337 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01538/2.031, allocations: 34.2 MB / 1.341 GB, free: 301.1 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.004855/2.036, allocations: 0.5438 MB / 1.341 GB, free: 300.5 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.00067/2.037, allocations: 0.5077 MB / 1.342 GB, free: 300 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 267
 * Number of states: 0 ()
 * Number of discrete variables: 414 ($PRE.controller.Transition1.enableFire,$PRE.controller.Transition2.enableFire,$PRE.controller.Transition3.enableFire,$PRE.controller.Transition4.enableFire,$PRE.controller.Transition5.enableFire,$PRE.controller.Transition6.enableFire,$PRE.controller.Transition7.enableFire,$PRE.controller.Transition8.enableFire,$PRE.controller.Transition9.enableFire,$PRE.controller.Transition10.enableFire,$PRE.controller.Transition11.enableFire,$PRE.controller.Transition12.enableFire,$PRE.controller.Transition13.enableFire,$PRE.controller.TransitionWithSignal1.enableFire,$PRE.controller.Transition13b.enableFire,$PRE.controller.Transition10b.enableFire,controller.Transition2.t_start,$PRE.controller.Transition2.t_start,controller.Transition4.t_start,$PRE.controller.Transition4.t_start,controller.Transition5.t_start,$PRE.controller.Transition5.t_start,controller.Transition6.t_start,$PRE.controller.Transition6.t_start,controller.Transition8.t_start,$PRE.controller.Transition8.t_start,controller.Transition9.t_start,$PRE.controller.Transition9.t_start,controller.Transition10.t_start,$PRE.controller.Transition10.t_start,controller.Transition11.t_start,$PRE.controller.Transition11.t_start,controller.Transition12.t_start,$PRE.controller.Transition12.t_start,controller.Transition13.t_start,$PRE.controller.Transition13.t_start,controller.TransitionWithSignal1.t_start,$PRE.controller.TransitionWithSignal1.t_start,controller.Transition10b.condition,controller.Transition13b.condition,controller.stateGraphRoot.resume,controller.stateGraphRoot.suspend,controller.Transition7.condition,controller.Transition3.condition,controller.Transition1.condition,controller.actuators.V21,controller.actuators.V19,controller.actuators.V10,controller.actuators.V4,controller.actuators.V2,pipeB7Pump.flowModel.states[2].phase,pipeB7Pump.flowModel.states[1].phase,pipeB6Pump.flowModel.states[2].phase,pipeB6Pump.flowModel.states[1].phase,pipeB1B1.flowModel.states[2].phase,pipeB1B1.flowModel.states[1].phase,pipeB2B3.flowModel.states[2].phase,pipeB2B3.flowModel.states[1].phase,pipeB1B3.flowModel.states[2].phase,pipeB1B3.flowModel.states[1].phase,volume4.medium.phase,B6.aboveLevel[1],$PRE.B6.aboveLevel[1],B6.ports_m_flow_out[1],$PRE.B6.ports_m_flow_out[1],B6.heatTransfer.states[1].phase,pipePump2B2.statesFM[2].phase,pipePump2B2.statesFM[1].phase,pipePump1B1.statesFM[2].phase,pipePump1B1.statesFM[1].phase,pipeB1B2.statesFM[2].phase,pipeB1B2.statesFM[1].phase,B7.aboveLevel[1],$PRE.B7.aboveLevel[1],B7.ports_m_flow_out[1],$PRE.B7.ports_m_flow_out[1],B7.heatTransfer.states[1].phase,B4.aboveLevel[1],$PRE.B4.aboveLevel[1],B4.ports_m_flow_out[1],$PRE.B4.ports_m_flow_out[1],B4.heatTransfer.states[1].phase,B3.aboveLevel[2],$PRE.B3.aboveLevel[2],B3.aboveLevel[1],$PRE.B3.aboveLevel[1],B3.ports_m_flow_out[2],$PRE.B3.ports_m_flow_out[2],B3.ports_m_flow_out[1],$PRE.B3.ports_m_flow_out[1],B3.heatTransfer.states[1].phase,B2.aboveLevel[1],$PRE.B2.aboveLevel[1],B2.ports_m_flow_out[1],$PRE.B2.ports_m_flow_out[1],B2.heatTransfer.states[1].phase,P2_on.T,P2_on.rate,P2_on.endValue,P1_on.T,P1_on.rate,P1_on.endValue,B1.aboveLevel[1],$PRE.B1.aboveLevel[1],B1.ports_m_flow_out[1],$PRE.B1.ports_m_flow_out[1],B1.heatTransfer.states[1].phase,P2.heatTransfer.states[1].phase,P1.heatTransfer.states[1].phase,V18.openingGenerator.T,V18.openingGenerator.rate,V18.openingGenerator.endValue,volume5.medium.phase,V21.openingGenerator.T,V21.openingGenerator.rate,V21.openingGenerator.endValue,V10.openingGenerator.T,V10.openingGenerator.rate,V10.openingGenerator.endValue,V19.openingGenerator.T,V19.openingGenerator.rate,V19.openingGenerator.endValue,V20.openingGenerator.T,V20.openingGenerator.rate,V20.openingGenerator.endValue,V25.openingGenerator.T,V25.openingGenerator.rate,V25.openingGenerator.endValue,V25.open,V24.openingGenerator.T,V24.openingGenerator.rate,V24.openingGenerator.endValue,V5.openingGenerator.T,V5.openingGenerator.rate,V5.openingGenerator.endValue,V22.openingGenerator.T,V22.openingGenerator.rate,V22.openingGenerator.endValue,V1.openingGenerator.T,V1.openingGenerator.rate,V1.openingGenerator.endValue,V23.openingGenerator.T,V23.openingGenerator.rate,V23.openingGenerator.endValue,V23.open,V6.openingGenerator.T,V6.openingGenerator.rate,V6.openingGenerator.endValue,V3.openingGenerator.T,V3.openingGenerator.rate,V3.openingGenerator.endValue,V4.openingGenerator.T,V4.openingGenerator.rate,V4.openingGenerator.endValue,V2.openingGenerator.T,V2.openingGenerator.rate,V2.openingGenerator.endValue,V9.openingGenerator.T,V9.openingGenerator.rate,V9.openingGenerator.endValue,V8.openingGenerator.T,V8.openingGenerator.rate,V8.openingGenerator.endValue,V11.openingGenerator.T,V11.openingGenerator.rate,V11.openingGenerator.endValue,controller.Transition10b.t_start,$PRE.controller.Transition10b.t_start,controller.Transition10b.fire,controller.Transition10b.enableFire,controller.Step10b.oldActive,$PRE.controller.Step10b.oldActive,controller.Step10b.newActive,$PRE.controller.Step10b.newActive,controller.Step10b.localActive,$PRE.controller.Step10b.localActive,controller.Step10b.active,controller.Transition13b.t_start,$PRE.controller.Transition13b.t_start,controller.Transition13b.fire,controller.Transition13b.enableFire,controller.Step13.oldActive,$PRE.controller.Step13.oldActive,controller.Step13.newActive,$PRE.controller.Step13.newActive,controller.Step13.localActive,$PRE.controller.Step13.localActive,controller.Step13.active,controller.stateGraphRoot.activeSteps,controller.TransitionWithSignal1.inPort.available,controller.TransitionWithSignal1.enableFire,controller.TransitionWithSignal1.localCondition,controller.T7_idle,controller.T5_idle,controller.Transition13.enableFire,controller.Transition13.localCondition,controller.Transition12.enableFire,controller.Transition12.localCondition,controller.Transition11.enableFire,controller.Transition11.localCondition,controller.Transition10.enableFire,controller.Transition10.localCondition,controller.Transition9.enableFire,controller.Transition9.localCondition,controller.Transition8.enableFire,controller.Step14.oldActive,$PRE.controller.Step14.oldActive,controller.Step14.newActive,$PRE.controller.Step14.newActive,controller.Step14.localActive,$PRE.controller.Step14.localActive,controller.Step14.active,controller.Step13b.oldActive,$PRE.controller.Step13b.oldActive,controller.Step13b.newActive,$PRE.controller.Step13b.newActive,controller.Step13b.localActive,$PRE.controller.Step13b.localActive,controller.Step13b.active,controller.Step12.oldActive,$PRE.controller.Step12.oldActive,controller.Step12.newActive,$PRE.controller.Step12.newActive,controller.Step12.localActive,$PRE.controller.Step12.localActive,controller.Step12.active,controller.Step11.oldActive,$PRE.controller.Step11.oldActive,controller.Step11.newActive,$PRE.controller.Step11.newActive,controller.Step11.localActive,$PRE.controller.Step11.localActive,controller.Step11.active,controller.Step10.oldActive,$PRE.controller.Step10.oldActive,controller.Step10.newActive,$PRE.controller.Step10.newActive,controller.Step10.localActive,$PRE.controller.Step10.localActive,controller.Step10.active,controller.Step9.oldActive,$PRE.controller.Step9.oldActive,controller.Step9.newActive,$PRE.controller.Step9.newActive,controller.Step9.localActive,$PRE.controller.Step9.localActive,controller.Step9.active,controller.Step8.oldActive,$PRE.controller.Step8.oldActive,controller.Step8.newActive,$PRE.controller.Step8.newActive,controller.Step8.localActive,$PRE.controller.Step8.localActive,controller.Step8.active,controller.Step7.oldActive,$PRE.controller.Step7.oldActive,controller.Step7.newActive,$PRE.controller.Step7.newActive,controller.Step7.localActive,$PRE.controller.Step7.localActive,controller.Step7.active,controller.Transition7.t_start,$PRE.controller.Transition7.t_start,controller.Transition7.outPort.occupied,controller.Transition7.fire,controller.Transition7.enableFire,controller.Step6.oldActive,$PRE.controller.Step6.oldActive,controller.Step6.newActive,$PRE.controller.Step6.newActive,controller.Step6.localActive,$PRE.controller.Step6.localActive,controller.Step6.active,controller.Transition6.enableFire,controller.Transition6.localCondition,controller.Step5.oldActive,$PRE.controller.Step5.oldActive,controller.Step5.newActive,$PRE.controller.Step5.newActive,controller.Step5.localActive,$PRE.controller.Step5.localActive,controller.Step5.active,controller.Transition5.enableFire,controller.Step4.oldActive,$PRE.controller.Step4.oldActive,controller.Step4.newActive,$PRE.controller.Step4.newActive,controller.Step4.localActive,$PRE.controller.Step4.localActive,controller.Step4.active,controller.Transition4.enableFire,controller.Transition4.localCondition,controller.Step3.oldActive,$PRE.controller.Step3.oldActive,controller.Step3.newActive,$PRE.controller.Step3.newActive,controller.Step3.localActive,$PRE.controller.Step3.localActive,controller.Step3.active,controller.Transition3.t_start,$PRE.controller.Transition3.t_start,controller.Transition3.fire,controller.Transition3.enableFire,controller.Step2.oldActive,$PRE.controller.Step2.oldActive,controller.Step2.newActive,$PRE.controller.Step2.newActive,controller.Step2.localActive,$PRE.controller.Step2.localActive,controller.Step2.active,controller.Transition2.enableFire,controller.Transition2.localCondition,controller.Step1.oldActive,$PRE.controller.Step1.oldActive,controller.Step1.newActive,$PRE.controller.Step1.newActive,controller.Step1.localActive,$PRE.controller.Step1.localActive,controller.Step1.active,controller.Transition1.t_start,$PRE.controller.Transition1.t_start,controller.Transition1.fire,controller.Transition1.enableFire,controller.InitialStep1.oldActive,$PRE.controller.InitialStep1.oldActive,controller.InitialStep1.newActive,$PRE.controller.InitialStep1.newActive,controller.InitialStep1.localActive,$PRE.controller.InitialStep1.localActive,controller.InitialStep1.active,V15.openingGenerator.T,V15.openingGenerator.rate,V15.openingGenerator.endValue,V12.openingGenerator.T,V12.openingGenerator.rate,V12.openingGenerator.endValue,B5.heatTransfer.states[1].phase,B5.InnerTankBottom[1].m_flow_negative,$PRE.B5.InnerTankBottom[1].m_flow_negative,B5.InnerTankSide[1].m_flow_negative,$PRE.B5.InnerTankSide[1].m_flow_negative,B5.InnerTankTop[1].m_flow_negative,$PRE.B5.InnerTankTop[1].m_flow_negative,$whenCondition1,$whenCondition2,$whenCondition3,$whenCondition4,$whenCondition5,$whenCondition6,$whenCondition7,$whenCondition8,$whenCondition9,$whenCondition10,$whenCondition11,$whenCondition12,$whenCondition13,$whenCondition14,$whenCondition15,$whenCondition16,$whenCondition17,$whenCondition18,$whenCondition19,$whenCondition20,$whenCondition21,$whenCondition22,$whenCondition23,pipePump2B2.state_b.phase,pipePump2B2.state_a.phase,pipePump1B1.state_b.phase,pipePump1B1.state_a.phase,pipeB1B2.state_b.phase,pipeB1B2.state_a.phase,P2.monitoring.state_in.phase,P1.monitoring.state_in.phase,V18.state_b.phase,V18.state_a.phase,V21.state_b.phase,V21.state_a.phase,V10.state_b.phase,V10.state_a.phase,V19.state_b.phase,V19.state_a.phase,V20.state_b.phase,V20.state_a.phase,V25.state_b.phase,V25.state_a.phase,V24.state_b.phase,V24.state_a.phase,V5.state_b.phase,V5.state_a.phase,V22.state_b.phase,V22.state_a.phase,V1.state_b.phase,V1.state_a.phase,V23.state_b.phase,V23.state_a.phase,V6.state_b.phase,V6.state_a.phase,V3.state_b.phase,V3.state_a.phase,V4.state_b.phase,V4.state_a.phase,V2.state_b.phase,V2.state_a.phase,V9.state_b.phase,V9.state_a.phase,V8.state_b.phase,V8.state_a.phase,V11.state_b.phase,V11.state_a.phase,V15.state_b.phase,V15.state_a.phase,V12.state_b.phase,V12.state_a.phase)
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1328):
 * Single equations (assignments): 1298
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 30
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,6,100.0%), (1,6,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 28 systems
   {(2,2), (1,5), (1,5), (2,2), (1,5), (1,2), (1,1), (1,5), (1,5), (2,7), (1,5), (2,7), (1,2), (1,1), (1,1), (1,6), (1,1), (1,1), (1,1), (2,10), (1,1), (1,1), (1,6), (1,1), (1,1), (1,1), (2,14), (2,10)}
Notification: Performance of prepare postOptimizeDAE: time 0.002096/2.039, allocations: 1.075 MB / 1.343 GB, free: 299 MB / 0.7761 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001377/2.04, allocations: 0.8618 MB / 1.343 GB, free: 298.1 MB / 0.7761 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02949/2.07, allocations: 38.48 MB / 1.381 GB, free: 259.8 MB / 0.7761 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0002002/2.07, allocations: 423.4 kB / 1.381 GB, free: 259.4 MB / 0.7761 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 3.498e-05/2.07, allocations: 4 kB / 1.381 GB, free: 259.4 MB / 0.7761 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.03584/2.106, allocations: 32.79 MB / 1.413 GB, free: 226.5 MB / 0.7761 GB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.06529/2.171, allocations: 52.32 MB / 1.465 GB, free: 174.4 MB / 0.7761 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.631e-05/2.171, allocations: 4 kB / 1.465 GB, free: 174.4 MB / 0.7761 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.004605/2.176, allocations: 1.593 MB / 1.466 GB, free: 172.8 MB / 0.7761 GB
Notification: Performance of postOpt tearingSystem (simulation): time 0.006649/2.182, allocations: 5.01 MB / 1.471 GB, free: 167.7 MB / 0.7761 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.002186/2.184, allocations: 315.8 kB / 1.471 GB, free: 167.4 MB / 0.7761 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01181/2.196, allocations: 27.62 MB / 1.498 GB, free: 138.6 MB / 0.7761 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.25e-06/2.196, allocations: 8 kB / 1.498 GB, free: 138.6 MB / 0.7761 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.04643/2.243, allocations: 36.91 MB / 1.534 GB, free: 101.4 MB / 0.7761 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.006385/2.249, allocations: 2.544 MB / 1.537 GB, free: 99.07 MB / 0.7761 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003408/2.253, allocations: 303.6 kB / 1.537 GB, free: 98.78 MB / 0.7761 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.006899/2.259, allocations: 471.5 kB / 1.538 GB, free: 98.32 MB / 0.7761 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00304/2.262, allocations: 0.96 MB / 1.539 GB, free: 97.35 MB / 0.7761 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.002086/2.265, allocations: 419.7 kB / 1.539 GB, free: 96.94 MB / 0.7761 GB
Notification: Performance of sorting global known variables: time 0.004652/2.269, allocations: 3.494 MB / 1.542 GB, free: 93.46 MB / 0.7761 GB
Notification: Performance of sort global known variables: time 1.9e-07/2.269, allocations: 0 / 1.542 GB, free: 93.46 MB / 0.7761 GB
Notification: Performance of remove unused functions: time 0.02367/2.293, allocations: 7.185 MB / 1.549 GB, free: 86.28 MB / 0.7761 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 24
 * Number of states: 34 (B5.medium.h,B5.level,volume5.medium.p,volume5.medium.h,P1.medium.p,P1.medium.h,P2.medium.p,P2.medium.h,B1.level,B1.medium.h,B2.level,B2.medium.h,B3.level,B3.medium.h,B4.level,B4.medium.h,B7.level,B7.medium.h,pipeB1B2.mediums[1].p,pipeB1B2.mediums[1].h,pipeB1B2.mediums[2].p,pipeB1B2.mediums[2].h,pipePump1B1.mediums[1].p,pipePump1B1.mediums[1].h,pipePump1B1.mediums[2].p,pipePump1B1.mediums[2].h,pipePump2B2.mediums[1].p,pipePump2B2.mediums[1].h,pipePump2B2.mediums[2].p,pipePump2B2.mediums[2].h,B6.level,B6.medium.h,volume4.medium.p,volume4.medium.h)
 * Number of discrete variables: 458 (controller.TransitionWithSignal1.t_start,controller.Transition13.t_start,controller.Transition12.t_start,controller.Transition11.t_start,controller.Transition10.t_start,controller.Transition9.t_start,controller.Transition8.t_start,controller.Transition6.t_start,controller.Transition5.t_start,controller.Transition4.t_start,controller.Transition2.t_start,controller.InitialStep1.localActive,controller.Transition1.enableFire,controller.Step1.active,controller.Step1.localActive,controller.Step2.active,controller.Step2.localActive,controller.Transition3.enableFire,controller.Step3.active,controller.Step3.localActive,controller.Step4.localActive,controller.Step5.active,controller.Step5.localActive,controller.Step6.localActive,controller.Transition7.enableFire,controller.Step7.localActive,controller.Step8.active,controller.Step8.localActive,controller.Step9.localActive,controller.Step10.active,V23.open,controller.Step10.localActive,controller.Transition10b.enableFire,controller.Step11.localActive,controller.Step12.localActive,V25.open,controller.Step13b.localActive,controller.Transition13b.enableFire,controller.Step14.localActive,controller.Step13.active,controller.Step13.localActive,controller.Step10b.localActive,$cse8.phase,$cse8.region,$cse9.phase,$cse9.region,$cse10.phase,$cse10.region,$cse11.phase,$cse11.region,$cse12.phase,$cse12.region,$cse13,$cse14,$cse15,$cse16,$cse17,$cse18,$cse19,$cse20,$cse21,$cse22,$cse23,$cse24,$cse25,$cse26,$cse27,$cse28,$cse29.phase,$cse29.region,$cse30.phase,$cse30.region,$cse31.phase,$cse31.region,$cse32.phase,$cse32.region,$cse33.phase,$cse33.region,$cse34.phase,$cse34.region,$cse35.phase,$cse35.region,$cse36.phase,$cse36.region,$cse37.phase,$cse37.region,$cse38.phase,$cse38.region,$cse39.phase,$cse39.region,$cse40.phase,$cse40.region,$cse41.phase,$cse41.region,$cse42.phase,$cse42.region,$cse43.phase,$cse43.region,$cse44.phase,$cse44.region,$cse45.phase,$cse45.region,$cse46.phase,$cse46.region,$cse47.phase,$cse47.region,$cse48.phase,$cse48.region,$cse49.phase,$cse49.region,$cse50.phase,$cse50.region,$cse51.phase,$cse51.region,$cse52.phase,$cse52.region,$cse53.phase,$cse53.region,$cse54.phase,$cse54.region,$cse57.phase,$cse57.region,$cse59.phase,$cse59.region,$cse60.phase,$cse60.region,$cse61.region3boundary,$cse62.region3boundary,$cse63.phase,$cse63.region,$cse64.phase,$cse64.region,$cse65.region3boundary,$cse66.region3boundary,$cse67.phase,$cse67.region,$cse68.phase,$cse68.region,$cse70.region3boundary,$cse71.region3boundary,$cse72.phase,$cse72.region,$cse73.phase,$cse73.region,$cse77.phase,$cse77.region,$cse78.phase,$cse78.region,$cse79.phase,$cse79.region,$cse80.phase,$cse80.region,$cse81.phase,$cse81.region,$cse82.region3boundary,$cse83.region3boundary,$cse84.phase,$cse84.region,$cse85.region3boundary,$cse86.region3boundary,$cse87.phase,$cse87.region,$cse89.phase,$cse89.region,$cse90.phase,$cse90.region,$cse91.phase,$cse91.region,$cse92.phase,$cse92.region,$cse94.phase,$cse94.region,$cse95.phase,$cse95.region,$cse97.phase,$cse97.region,$cse98.phase,$cse98.region,$cse100.phase,$cse100.region,$cse101.phase,$cse101.region,$cse103.phase,$cse103.region,$cse104.phase,$cse104.region,$cse106.region3boundary,$cse107.region3boundary,$cse108.phase,$cse108.region,$cse109.region3boundary,$cse110.region3boundary,$cse111.phase,$cse111.region,$cse113.phase,$cse113.region,$cse114.phase,$cse114.region,$cse115.region3boundary,$cse116.region3boundary,$cse117.phase,$cse117.region,$cse118.region3boundary,$cse119.region3boundary,$cse120.phase,$cse120.region,$cse122.phase,$cse122.region,$cse123.phase,$cse123.region,$cse124.phase,$cse124.region,$cse128.region3boundary,$cse129.region3boundary,$cse130.phase,$cse130.region,$cse132.phase,$cse132.region,$cse133.phase,$cse133.region,$cse137.phase,$cse137.region,$cse139.phase,$cse139.region,$cse141.phase,$cse141.region,$cse143.phase,$cse143.region,$cse147.phase,$cse147.region,$cse149.phase,$cse149.region,$cse151.phase,$cse151.region,$cse153.phase,$cse153.region,$cse155.phase,$cse155.region,$cse157.phase,$cse157.region,$cse159.phase,$cse159.region,$cse160.phase,$cse160.region,$cse162.phase,$cse162.region,$cse163.phase,$cse163.region,$cse165.phase,$cse165.region,$cse167.phase,$cse167.region,$cse168.phase,$cse168.region,$cse170.phase,$cse170.region,$whenCondition23,$whenCondition22,$whenCondition21,$whenCondition20,$whenCondition19,$whenCondition18,$whenCondition17,$whenCondition16,$whenCondition15,$whenCondition14,$whenCondition13,$whenCondition12,$whenCondition11,$whenCondition10,$whenCondition9,$whenCondition8,$whenCondition7,$whenCondition6,$whenCondition5,$whenCondition4,$whenCondition3,$whenCondition2,$whenCondition1,B5.InnerTankTop[1].m_flow_negative,B5.InnerTankSide[1].m_flow_negative,B5.InnerTankBottom[1].m_flow_negative,B5.heatTransfer.states[1].phase,V12.openingGenerator.endValue,V12.openingGenerator.rate,V12.openingGenerator.T,V15.openingGenerator.endValue,V15.openingGenerator.rate,V15.openingGenerator.T,controller.InitialStep1.active,controller.InitialStep1.newActive,controller.InitialStep1.oldActive,controller.Transition1.fire,controller.Transition1.t_start,controller.Step1.newActive,controller.Step1.oldActive,controller.Transition2.localCondition,controller.Transition2.enableFire,controller.Step2.newActive,controller.Step2.oldActive,controller.Transition3.fire,controller.Transition3.t_start,controller.Step3.newActive,controller.Step3.oldActive,controller.Transition4.localCondition,controller.Transition4.enableFire,controller.Step4.active,controller.Step4.newActive,controller.Step4.oldActive,controller.Transition5.enableFire,controller.Step5.newActive,controller.Step5.oldActive,controller.Transition6.localCondition,controller.Transition6.enableFire,controller.Step6.active,controller.Step6.newActive,controller.Step6.oldActive,controller.Transition7.fire,controller.Transition7.outPort.occupied,controller.Transition7.t_start,controller.Step7.active,controller.Step7.newActive,controller.Step7.oldActive,controller.Step8.newActive,controller.Step8.oldActive,controller.Step9.active,controller.Step9.newActive,controller.Step9.oldActive,controller.Step10.newActive,controller.Step10.oldActive,controller.Step11.active,controller.Step11.newActive,controller.Step11.oldActive,controller.Step12.active,controller.Step12.newActive,controller.Step12.oldActive,controller.Step13b.active,controller.Step13b.newActive,controller.Step13b.oldActive,controller.Step14.active,controller.Step14.newActive,controller.Step14.oldActive,controller.Transition8.enableFire,controller.Transition9.localCondition,controller.Transition9.enableFire,controller.Transition10.localCondition,controller.Transition10.enableFire,controller.Transition11.localCondition,controller.Transition11.enableFire,controller.Transition12.localCondition,controller.Transition12.enableFire,controller.Transition13.localCondition,controller.Transition13.enableFire,controller.T5_idle,controller.T7_idle,controller.TransitionWithSignal1.localCondition,controller.TransitionWithSignal1.enableFire,controller.TransitionWithSignal1.inPort.available,controller.stateGraphRoot.activeSteps,controller.Step13.newActive,controller.Step13.oldActive,controller.Transition13b.fire,controller.Transition13b.t_start,controller.Step10b.active,controller.Step10b.newActive,controller.Step10b.oldActive,controller.Transition10b.fire,controller.Transition10b.t_start,V11.openingGenerator.endValue,V11.openingGenerator.rate,V11.openingGenerator.T,V8.openingGenerator.endValue,V8.openingGenerator.rate,V8.openingGenerator.T,V9.openingGenerator.endValue,V9.openingGenerator.rate,V9.openingGenerator.T,V2.openingGenerator.endValue,V2.openingGenerator.rate,V2.openingGenerator.T,V4.openingGenerator.endValue,V4.openingGenerator.rate,V4.openingGenerator.T,V3.openingGenerator.endValue,V3.openingGenerator.rate,V3.openingGenerator.T,V6.openingGenerator.endValue,V6.openingGenerator.rate,V6.openingGenerator.T,V23.openingGenerator.endValue,V23.openingGenerator.rate,V23.openingGenerator.T,V1.openingGenerator.endValue,V1.openingGenerator.rate,V1.openingGenerator.T,V22.openingGenerator.endValue,V22.openingGenerator.rate,V22.openingGenerator.T,V5.openingGenerator.endValue,V5.openingGenerator.rate,V5.openingGenerator.T,V24.openingGenerator.endValue,V24.openingGenerator.rate,V24.openingGenerator.T,V25.openingGenerator.endValue,V25.openingGenerator.rate,V25.openingGenerator.T,V20.openingGenerator.endValue,V20.openingGenerator.rate,V20.openingGenerator.T,V19.openingGenerator.endValue,V19.openingGenerator.rate,V19.openingGenerator.T,V10.openingGenerator.endValue,V10.openingGenerator.rate,V10.openingGenerator.T,V21.openingGenerator.endValue,V21.openingGenerator.rate,V21.openingGenerator.T,volume5.medium.phase,V18.openingGenerator.endValue,V18.openingGenerator.rate,V18.openingGenerator.T,P1.heatTransfer.states[1].phase,P2.heatTransfer.states[1].phase,B1.heatTransfer.states[1].phase,B1.ports_m_flow_out[1],B1.aboveLevel[1],P1_on.endValue,P1_on.rate,P1_on.T,P2_on.endValue,P2_on.rate,P2_on.T,B2.heatTransfer.states[1].phase,B2.ports_m_flow_out[1],B2.aboveLevel[1],B3.heatTransfer.states[1].phase,B3.ports_m_flow_out[1],B3.ports_m_flow_out[2],B3.aboveLevel[1],B3.aboveLevel[2],B4.heatTransfer.states[1].phase,B4.ports_m_flow_out[1],B4.aboveLevel[1],B7.heatTransfer.states[1].phase,B7.ports_m_flow_out[1],B7.aboveLevel[1],pipeB1B2.statesFM[1].phase,pipeB1B2.statesFM[2].phase,pipePump1B1.statesFM[1].phase,pipePump1B1.statesFM[2].phase,pipePump2B2.statesFM[1].phase,pipePump2B2.statesFM[2].phase,B6.heatTransfer.states[1].phase,B6.ports_m_flow_out[1],B6.aboveLevel[1],volume4.medium.phase)
 * Number of discrete states: 67 (V2.openingGenerator.y,V4.openingGenerator.y,V19.openingGenerator.y,V10.openingGenerator.y,V21.openingGenerator.y,B6.aboveLevel[1],B7.aboveLevel[1],B4.aboveLevel[1],B3.aboveLevel[2],B3.aboveLevel[1],B2.aboveLevel[1],B1.aboveLevel[1],B3.ports_m_flow_out[2],controller.Step10b.newActive,controller.Step13.newActive,V20.openingGenerator.y,V6.openingGenerator.y,controller.Step14.newActive,controller.Step13b.newActive,P2_on.y,V25.openingGenerator.y,V24.openingGenerator.y,V5.openingGenerator.y,controller.Step12.newActive,controller.Step11.newActive,controller.Step10.newActive,P1_on.y,V22.openingGenerator.y,V1.openingGenerator.y,V23.openingGenerator.y,V18.openingGenerator.y,B7.ports_m_flow_out[1],V3.openingGenerator.y,controller.Step9.newActive,controller.Step8.newActive,V15.openingGenerator.y,controller.Step7.newActive,controller.Step6.newActive,controller.Step5.newActive,V12.openingGenerator.y,controller.Step4.newActive,controller.Step3.newActive,V11.openingGenerator.y,B3.ports_m_flow_out[1],controller.Step2.newActive,V9.openingGenerator.y,B2.ports_m_flow_out[1],controller.Step1.newActive,V8.openingGenerator.y,B1.ports_m_flow_out[1],controller.InitialStep1.newActive,B5.InnerTankTop[1].m_flow_negative,B4.ports_m_flow_out[1],B5.InnerTankSide[1].m_flow_negative,B5.InnerTankBottom[1].m_flow_negative,B6.ports_m_flow_out[1],controller.Transition2.t_start,controller.Transition4.t_start,controller.Transition5.t_start,controller.Transition6.t_start,controller.Transition8.t_start,controller.Transition9.t_start,controller.Transition10.t_start,controller.Transition11.t_start,controller.Transition12.t_start,controller.Transition13.t_start,controller.TransitionWithSignal1.t_start)
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (1024):
 * Single equations (assignments): 795
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 101
 * When equations: 99
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 29
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems (#iteration vars, #inner vars, density): 2 systems
   {(1,6,100.0%), (1,6,100.0%)}
 * Non-linear torn systems (#iteration vars, #inner vars): 27 systems
   {(1,1), (1,1), (1,1), (2,6), (1,1), (2,6), (1,1), (1,1), (1,1), (1,1), (1,1), (1,1), (2,2), (1,5), (2,4), (2,4), (2,4), (2,4), (2,4), (2,19), (2,13), (1,2), (2,2), (2,9), (2,9), (2,13), (1,2)}
Notification: Performance of Backend phase and start with SimCode phase: time 0.06308/2.356, allocations: 39.87 MB / 1.588 GB, free: 46.38 MB / 0.7761 GB
Notification: Performance of simCode: created initialization part: time 0.0412/2.397, allocations: 24.85 MB / 1.613 GB, free: 21.31 MB / 0.7761 GB
Notification: Performance of simCode: created event and clocks part: time 1.325e-05/2.397, allocations: 4.781 kB / 1.613 GB, free: 21.3 MB / 0.7761 GB
Notification: Performance of simCode: created simulation system equations: time 0.01712/2.414, allocations: 12.62 MB / 1.625 GB, free: 8.633 MB / 0.7761 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01617/2.43, allocations: 3.929 MB / 1.629 GB, free: 4.758 MB / 0.7761 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.3559/2.786, allocations: 121 MB / 1.747 GB, free: 367.9 MB / 0.7761 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.008277/2.795, allocations: 6.544 MB / 1.753 GB, free: 361.3 MB / 0.7761 GB
Notification: Performance of simCode: alias equations: time 0.0137/2.808, allocations: 9.691 MB / 1.763 GB, free: 351.8 MB / 0.7761 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.007755/2.816, allocations: 6.206 MB / 1.769 GB, free: 345.6 MB / 0.7761 GB
Notification: Performance of SimCode: time 2.014e-06/2.816, allocations: 0 / 1.769 GB, free: 345.6 MB / 0.7761 GB
Notification: Performance of buildModelFMU: Generate the FMI files: time 0.5356/3.352, allocations: 389.7 MB / 2.149 GB, free: 361.3 MB / 0.7761 GB
Notification: Performance of buildModelFMU: Generate platform static: time 30.34/33.69, allocations: 3.938 kB / 2.149 GB, free: 361.3 MB / 0.7761 GB
"
[Timeout remaining time 626]
(rm -f Modelica_4.0.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.pipe ; mkfifo Modelica_4.0.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.pipe ; head -c 1048576 < Modelica_4.0.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.pipe >> ../files/Modelica_4.0.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.sim & python3 -m fmpy simulate  --output-file Modelica_4.0.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater_res.csv --start-time 0 --stop-time 3600 --timeout 50 --relative-tolerance 1e-06 --interface-type ModelExchange --solver CVode --output-interval 1 Modelica_4_0_0_Modelica_Fluid_Examples_AST_BatchPlant_BatchPlant_StandardWater.fmu > Modelica_4.0.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.pipe 2>&1) [Timeout 52.5]
[Calling os._exit(0), Time elapsed: 35.769112720154226]
Failed to read output from testmodel.py, exit status != 0:
['time', 'B1.level', 'B1.medium.h', 'B2.level', 'B2.medium.h', 'B3.level', 'B3.medium.h', 'B4.level', 'B4.medium.h', 'B5.level', 'B5.medium.h', 'B6.level', 'B6.medium.h', 'B7.level', 'B7.medium.h', 'P1.medium.h', 'P1.medium.p', 'P2.medium.h', 'P2.medium.p', 'pipeB1B2.mediums[1].h', 'pipeB1B2.mediums[1].p', 'pipeB1B2.mediums[2].h', 'pipeB1B2.mediums[2].p', 'pipePump1B1.mediums[1].h', 'pipePump1B1.mediums[1].p', 'pipePump1B1.mediums[2].h', 'pipePump1B1.mediums[2].p', 'pipePump2B2.mediums[1].h', 'pipePump2B2.mediums[1].p', 'pipePump2B2.mediums[2].h', 'pipePump2B2.mediums[2].p', 'volume4.medium.h', 'volume4.medium.p', 'volume5.medium.h', 'volume5.medium.p', 'B5.InnerTankBottom[1].m_flow_negative', 'B5.InnerTankSide[1].m_flow_negative', 'B5.InnerTankTop[1].m_flow_negative', 'P1_on.y', 'P2_on.y', 'controller.Transition1.enableFire', 'controller.Transition10.enableFire', 'controller.Transition11.enableFire', 'controller.Transition12.enableFire', 'controller.Transition13.enableFire', 'controller.Transition2.enableFire', 'controller.Transition3.enableFire', 'controller.Transition4.enableFire', 'controller.Transition5.enableFire', 'controller.Transition6.enableFire', 'controller.Transition7.enableFire', 'controller.Transition8.enableFire', 'controller.Transition9.enableFire', 'controller.TransitionWithSignal1.enableFire']
33.983634444884956 33.996792069 32.653562816
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fe4529ad190>