Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.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.001325/0.001325, allocations: 110.4 kB / 21.19 MB, free: 0.6641 MB / 14.72 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.001406/0.001406, allocations: 204.7 kB / 24.49 MB, free: 3.965 MB / 14.72 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 1.434/1.434, allocations: 230.6 MB / 258.3 MB, free: 7.805 MB / 206.1 MB
"
[Timeout remaining time 178]
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: translateModel(Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater,tolerance=1e-06,outputFormat="mat",numberOfIntervals=3600,variableFilter="time|B5.medium.h|B5.level|B5.InnerTankTop.1..m_flow_negative|B5.InnerTankSide.1..m_flow_negative|B5.InnerTankBottom.1..m_flow_negative|controller.Transition1.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.Transition10.enableFire|controller.Transition11.enableFire|controller.Transition12.enableFire|controller.Transition13.enableFire|controller.TransitionWithSignal1.enableFire|volume5.medium.p|volume5.medium.h|P1.medium.p|P1.medium.h|P2.medium.p|P2.medium.h|B1.level|B1.medium.h|P1_on.y|P2_on.y|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",fileNamePrefix="Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater")
translateModel(Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater,tolerance=1e-06,outputFormat="mat",numberOfIntervals=3600,variableFilter="time|B5.medium.h|B5.level|B5.InnerTankTop.1..m_flow_negative|B5.InnerTankSide.1..m_flow_negative|B5.InnerTankBottom.1..m_flow_negative|controller.Transition1.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.Transition10.enableFire|controller.Transition11.enableFire|controller.Transition12.enableFire|controller.Transition13.enableFire|controller.TransitionWithSignal1.enableFire|volume5.medium.p|volume5.medium.h|P1.medium.p|P1.medium.h|P2.medium.p|P2.medium.h|B1.level|B1.medium.h|P1_on.y|P2_on.y|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",fileNamePrefix="Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater") [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001611/0.001611, allocations: 47.92 kB / 379 MB, free: 2.473 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.2065/0.2081, allocations: 53.37 MB / 432.4 MB, free: 6.727 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater): time 0.915/1.123, allocations: 389.8 MB / 0.8029 GB, free: 0.6211 MB / 0.5919 GB
Notification: Performance of NFInst.instExpressions: time 0.0854/1.209, allocations: 85.24 MB / 0.8861 GB, free: 14.58 MB / 0.6075 GB
Notification: Performance of NFInst.updateImplicitVariability: time 0.008481/1.217, allocations: 315 kB / 0.8864 GB, free: 14.58 MB / 0.6075 GB
Notification: Performance of NFTyping.typeComponents: time 0.01135/1.228, allocations: 4.354 MB / 0.8907 GB, free: 13.47 MB / 0.6075 GB
Notification: Performance of NFTyping.typeBindings: time 0.05151/1.28, allocations: 20.73 MB / 0.9109 GB, free: 3.395 MB / 0.6075 GB
Notification: Performance of NFTyping.typeClassSections: time 0.04554/1.325, allocations: 18.3 MB / 0.9288 GB, free: 5.102 MB / 0.6231 GB
Notification: Performance of NFFlatten.flatten: time 0.03552/1.361, allocations: 26.47 MB / 0.9546 GB, free: 11.49 MB / 0.6544 GB
Notification: Performance of NFFlatten.resolveConnections: time 0.0119/1.373, allocations: 6.836 MB / 0.9613 GB, free: 4.719 MB / 0.6544 GB
Notification: Performance of NFEvalConstants.evaluate: time 0.01875/1.392, allocations: 9.89 MB / 0.971 GB, free: 11.32 MB / 0.67 GB
Notification: Performance of NFSimplifyModel.simplify: time 0.07417/1.466, allocations: 38.98 MB / 1.009 GB, free: 4.711 MB / 0.7012 GB
Notification: Performance of NFPackage.collectConstants: time 0.004336/1.47, allocations: 1.191 MB / 1.01 GB, free: 3.52 MB / 0.7012 GB
Notification: Performance of NFFlatten.collectFunctions: time 0.03687/1.507, allocations: 15.97 MB / 1.026 GB, free: 3.875 MB / 0.7169 GB
Notification: Performance of NFScalarize.scalarize: time 0.006261/1.513, allocations: 3.783 MB / 1.029 GB, free: 180 kB / 0.7169 GB
Notification: Performance of NFVerifyModel.verify: time 0.009896/1.523, allocations: 5.291 MB / 1.035 GB, free: 10.95 MB / 0.7325 GB
Notification: Performance of NFConvertDAE.convert: time 0.3736/1.897, allocations: 26.58 MB / 1.061 GB, free: 82.29 MB / 0.7325 GB
Notification: Performance of FrontEnd - DAE generated: time 4.369e-06/1.897, allocations: 0.75 kB / 1.061 GB, free: 82.29 MB / 0.7325 GB
Notification: Performance of FrontEnd: time 1.382e-06/1.897, allocations: 0 / 1.061 GB, free: 82.29 MB / 0.7325 GB
Notification: Performance of Transformations before backend: time 0.0004164/1.897, allocations: 1.25 kB / 1.061 GB, free: 82.29 MB / 0.7325 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.04767/1.945, allocations: 17.04 MB / 1.077 GB, free: 74.77 MB / 0.7325 GB
Notification: Performance of prepare preOptimizeDAE: time 3.903e-05/1.945, allocations: 8.094 kB / 1.077 GB, free: 74.77 MB / 0.7325 GB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02664/1.971, allocations: 3.5 MB / 1.081 GB, free: 74.15 MB / 0.7325 GB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02263/1.994, allocations: 11.02 MB / 1.091 GB, free: 72.79 MB / 0.7325 GB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.001238/1.995, allocations: 1.704 MB / 1.093 GB, free: 71.74 MB / 0.7325 GB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003077/1.998, allocations: 0.9381 MB / 1.094 GB, free: 71.73 MB / 0.7325 GB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03772/2.036, allocations: 16.5 MB / 1.11 GB, free: 68.32 MB / 0.7325 GB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002114/2.036, allocations: 35.11 kB / 1.11 GB, free: 68.32 MB / 0.7325 GB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001249/2.038, allocations: 400 kB / 1.111 GB, free: 68.32 MB / 0.7325 GB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.0005539/2.038, allocations: 0.5735 MB / 1.111 GB, free: 68.3 MB / 0.7325 GB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03231/2.07, allocations: 13.81 MB / 1.125 GB, free: 68.19 MB / 0.7325 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.06281/2.133, allocations: 42.75 MB / 1.166 GB, free: 52.09 MB / 0.7325 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.02343/2.157, allocations: 11.27 MB / 1.177 GB, free: 45.52 MB / 0.7325 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.009355/2.166, allocations: 5.22 MB / 1.182 GB, free: 41.91 MB / 0.7325 GB
Notification: Performance of preOpt evalFunc (simulation): time 0.1144/2.28, allocations: 34.99 MB / 1.217 GB, free: 7 MB / 0.7325 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 0.0226/2.303, allocations: 8.75 MB / 1.225 GB, free: 14.02 MB / 0.7481 GB
Notification: Performance of preOpt simplifyInStream (simulation): time 0.004694/2.308, allocations: 0.8353 MB / 1.226 GB, free: 13.19 MB / 0.7481 GB
Notification: Performance of pre-optimization done (n=925): time 1.982e-05/2.308, allocations: 0 / 1.226 GB, free: 13.19 MB / 0.7481 GB
Notification: Performance of matching and sorting (n=999): time 0.2039/2.512, allocations: 62.99 MB / 1.287 GB, free: 14.71 MB / 0.8106 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0004262/2.512, allocations: 0.6133 MB / 1.288 GB, free: 13.98 MB / 0.8106 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008204/2.52, allocations: 5.066 MB / 1.293 GB, free: 8.914 MB / 0.8106 GB
Notification: Performance of collectPreVariables (initialization): time 0.00196/2.522, allocations: 302 kB / 1.293 GB, free: 8.613 MB / 0.8106 GB
Notification: Performance of collectInitialEqns (initialization): time 0.00381/2.526, allocations: 3.91 MB / 1.297 GB, free: 4.766 MB / 0.8106 GB
Notification: Performance of collectInitialBindings (initialization): time 0.004249/2.53, allocations: 3.297 MB / 1.3 GB, free: 1.527 MB / 0.8106 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.004152/2.535, allocations: 2.256 MB / 1.303 GB, free: 15.27 MB / 0.8262 GB
Notification: Performance of setup shared object (initialization): time 0.0001234/2.535, allocations: 302.7 kB / 1.303 GB, free: 14.97 MB / 0.8262 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.01096/2.546, allocations: 4.994 MB / 1.308 GB, free: 9.969 MB / 0.8262 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01315/2.559, allocations: 7.326 MB / 1.315 GB, free: 1.809 MB / 0.8262 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.02358/2.582, allocations: 11.9 MB / 1.327 GB, free: 5.277 MB / 0.8419 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.17e-05/2.582, allocations: 16 kB / 1.327 GB, free: 5.262 MB / 0.8419 GB
Notification: Performance of matching and sorting (n=1456) (initialization): time 0.0366/2.619, allocations: 15.17 MB / 1.341 GB, free: 6.312 MB / 0.8575 GB
Notification: Performance of prepare postOptimizeDAE: time 6.516e-05/2.619, allocations: 32.97 kB / 1.341 GB, free: 6.281 MB / 0.8575 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 9.433e-05/2.619, allocations: 59.94 kB / 1.341 GB, free: 6.223 MB / 0.8575 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01313/2.632, allocations: 3.249 MB / 1.345 GB, free: 2.898 MB / 0.8575 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01078/2.643, allocations: 2.283 MB / 1.347 GB, free: 0.7578 MB / 0.8575 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.2317/2.875, allocations: 25.14 MB / 1.371 GB, free: 470.6 MB / 0.8731 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009096/2.884, allocations: 0.5424 MB / 1.372 GB, free: 470.6 MB / 0.8731 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001739/2.886, allocations: 0.499 MB / 1.372 GB, free: 470.6 MB / 0.8731 GB
Notification: Performance of preBalanceInitialSystem (initialization_lambda0): time 0.01367/2.899, allocations: 6.434 MB / 1.379 GB, free: 470.5 MB / 0.8731 GB
Notification: Performance of partitionIndependentBlocks (initialization_lambda0): time 0.01087/2.91, allocations: 7.242 MB / 1.386 GB, free: 468 MB / 0.8731 GB
Notification: Performance of analyzeInitialSystem (initialization_lambda0): time 0.01882/2.929, allocations: 11.7 MB / 1.397 GB, free: 463 MB / 0.8731 GB
Notification: Performance of solveInitialSystemEqSystem (initialization_lambda0): time 5.307e-05/2.929, allocations: 15.59 kB / 1.397 GB, free: 463 MB / 0.8731 GB
Notification: Performance of matching and sorting (n=1456) (initialization_lambda0): time 0.03062/2.96, allocations: 14.9 MB / 1.412 GB, free: 457.8 MB / 0.8731 GB
Notification: Performance of prepare postOptimizeDAE: time 5.225e-05/2.96, allocations: 31.75 kB / 1.412 GB, free: 457.8 MB / 0.8731 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 7.585e-05/2.96, allocations: 65.97 kB / 1.412 GB, free: 457.8 MB / 0.8731 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007652/2.967, allocations: 2.451 MB / 1.414 GB, free: 457 MB / 0.8731 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01022/2.978, allocations: 2.32 MB / 1.416 GB, free: 456.8 MB / 0.8731 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.02768/3.005, allocations: 33.95 MB / 1.45 GB, free: 427.8 MB / 0.8731 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.008843/3.014, allocations: 0.5404 MB / 1.45 GB, free: 427.6 MB / 0.8731 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001907/3.016, allocations: 0.4924 MB / 1.451 GB, free: 427.5 MB / 0.8731 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.003764/3.02, allocations: 1.074 MB / 1.452 GB, free: 426.8 MB / 0.8731 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.002378/3.022, allocations: 0.8283 MB / 1.453 GB, free: 426.8 MB / 0.8731 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.05022/3.072, allocations: 38.12 MB / 1.49 GB, free: 394.9 MB / 0.8731 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 0.04536/3.118, allocations: 32.56 MB / 1.522 GB, free: 365.4 MB / 0.8731 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 7.995e-05/3.118, allocations: 4 kB / 1.522 GB, free: 365.4 MB / 0.8731 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.00683/3.125, allocations: 2.47 MB / 1.524 GB, free: 364.1 MB / 0.8731 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003487/3.128, allocations: 296.9 kB / 1.524 GB, free: 363.8 MB / 0.8731 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.008312/3.136, allocations: 0.5962 MB / 1.525 GB, free: 363.4 MB / 0.8731 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.002659/3.139, allocations: 0.9709 MB / 1.526 GB, free: 362.6 MB / 0.8731 GB
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/DAEMode.mo:521:7-523:90:writable] Error: Internal error DAEMode.traverserStrongComponents failed on equation:
1/1 (1): pipeB1B1.flowModel.m_flows[1] = V10.openingGenerator.y * V10.k * V10.dp
2/2 (1): V10.dp = pipeB1B1.flowModel.states[2].p - volume4.medium.p
3/3 (16): $cse82 = Modelica.Media.Water.IF97_Utilities.waterBaseProp_ph(pipeB1B1.flowModel.states[2].p, volume4.medium.h, 0, 0)
4/19 (1): pipeB1B1.flowModel.rhos[2] = $cse82.rho
5/20 (1): pipeB1B1.flowModel.mus[2] = Modelica.Media.Water.IF97_Utilities.dynamicViscosity(pipeB1B1.flowModel.rhos[2], pipeB1B1.flowModel.states[2].T, pipeB1B1.flowModel.states[2].p, 0, true)
6/21 (1): $cse83 = Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater.pipeB1B1.flowModel.WallFriction.massFlowRate_dp_staticHead(pipeB1B1.flowModel.dps_fg[1], pipeB1B1.flowModel.rhos[1], pipeB1B1.flowModel.rhos[2], pipeB1B1.flowModel.mus[1], pipeB1B1.flowModel.mus[2], pipeB1B1.length, pipeB1B1.flowModel.diameters[1], pipeB1B1.flowModel.g * pipeB1B1.height_ab, pipeB1B1.crossArea, pipeB1B1.roughness, pipeB1B1.flowModel.dp_small, 4000.0)
7/22 (1): pipeB1B1.flowModel.dps_fg[1] = (-2.0) * pipeB1B1.flowModel.Fs_p[1] / (2.0 * pipeB1B1.crossArea * pipeB1B1.flowModel.nParallel)
8/23 (1): pipeB1B1.flowModel.Fs_p[1] = pipeB1B1.flowModel.nParallel * pipeB1B1.crossArea * (pipeB1B1.flowModel.states[2].p - pipeB1B1.flowModel.states[1].p)
9/24 (16): $cse81 = Modelica.Media.Water.IF97_Utilities.waterBaseProp_ph(pipeB1B1.flowModel.states[1].p, B3.medium.h, 0, 0)
10/40 (1): pipeB1B1.flowModel.rhos[1] = $cse81.rho
11/41 (1): pipeB1B1.flowModel.mus[1] = Modelica.Media.Water.IF97_Utilities.dynamicViscosity(pipeB1B1.flowModel.rhos[1], pipeB1B1.flowModel.states[1].T, pipeB1B1.flowModel.states[1].p, 0, true)
12/42 (1): pipeB1B1.flowModel.states[1].T = $cse81.T
13/43 (1): 0.0 = if B3.aboveLevel[2] then pipeB1B1.flowModel.states[1].p - (101325.0 + B3.levelAbovePort[2] * system.g * B3.heatTransfer.states[1].d - smooth(2, if noEvent((-pipeB1B1.flowModel.m_flows[1]) < 0.0) then pipeB1B1.flowModel.m_flows[1] ^ 2.0 / (2.0 * B3.heatTransfer.states[1].d * B3.bottomArea[2] ^ 2.0) else 0.0)) else -(if pre(B3.ports_m_flow_out[2]) then -pipeB1B1.flowModel.m_flows[1] else pipeB1B1.flowModel.states[1].p - 101325.0)
14/44 (1): pipeB1B1.flowModel.m_flows[1] = $cse83 * pipeB1B1.flowModel.nParallel
15/45 (1): pipeB1B1.flowModel.states[2].T = $cse82.T

Variables:
1: pipeB1B1.flowModel.states[2].T:VARIABLE(min = 273.15 max = 2273.15 start = 500.0 unit = \"K\" nominal = 500.0 )  \"Temperature\" type: Real [2]
2: $cse83:VARIABLE(protected = true )  type: Real unreplaceable
3: pipeB1B1.flowModel.m_flows[1]:VARIABLE(min = -1e5 max = 1e5 start = 0.0 unit = \"kg/s\" )  \"Mass flow rates between states\" type: Real [1]
4: pipeB1B1.flowModel.states[1].T:VARIABLE(min = 273.15 max = 2273.15 start = 500.0 unit = \"K\" nominal = 500.0 )  \"Temperature\" type: Real [2]
5: pipeB1B1.flowModel.mus[1]:VARIABLE(min = 0.0 max = 1e8 start = 0.001 unit = \"Pa.s\" nominal = 0.001 )  type: Real [2]
6: pipeB1B1.flowModel.rhos[1]:VARIABLE(min = 0.0 max = 1e5 start = 150.0 unit = \"kg/m3\" nominal = 500.0 )  type: Real [2]
7: $cse81.cv:VARIABLE(protected = true )  type: Real unreplaceable
8: $cse81.dpT:VARIABLE(protected = true )  type: Real unreplaceable
9: $cse81.cp:VARIABLE(protected = true )  type: Real unreplaceable
10: $cse81.pt:VARIABLE(protected = true )  type: Real unreplaceable
11: $cse81.s:VARIABLE(protected = true )  type: Real unreplaceable
12: $cse81.phase:DISCRETE(protected = true )  type: Integer unreplaceable
13: $cse81.p:VARIABLE(protected = true )  type: Real unreplaceable
14: $cse81.pd:VARIABLE(protected = true )  type: Real unreplaceable
15: $cse81.R_s:VARIABLE(protected = true )  type: Real unreplaceable
16: $cse81.h:VARIABLE(protected = true )  type: Real unreplaceable
17: $cse81.x:VARIABLE(protected = true )  type: Real unreplaceable
18: $cse81.vt:VARIABLE(protected = true )  type: Real unreplaceable
19: $cse81.rho:VARIABLE(protected = true )  type: Real unreplaceable
20: $cse81.vp:VARIABLE(protected = true )  type: Real unreplaceable
21: $cse81.region:DISCRETE(protected = true )  type: Integer unreplaceable
22: $cse81.T:VARIABLE(protected = true )  type: Real unreplaceable
23: pipeB1B1.flowModel.states[1].p:VARIABLE(min = 611.657 max = 1e8 start = 5e6 unit = \"Pa\" nominal = 1e6 )  \"Pressure\" type: Real [2]
24: pipeB1B1.flowModel.Fs_p[1]:VARIABLE(unit = \"N\" )  \"Pressure forces\" type: Real [1]
25: pipeB1B1.flowModel.dps_fg[1]:VARIABLE(start = 0.0 unit = \"Pa\" )  \"Pressure drop between states\" type: Real [1]
26: pipeB1B1.flowModel.mus[2]:VARIABLE(min = 0.0 max = 1e8 start = 0.001 unit = \"Pa.s\" nominal = 0.001 )  type: Real [2]
27: pipeB1B1.flowModel.rhos[2]:VARIABLE(min = 0.0 max = 1e5 start = 150.0 unit = \"kg/m3\" nominal = 500.0 )  type: Real [2]
28: $cse82.region:DISCRETE(protected = true )  type: Integer unreplaceable
29: $cse82.s:VARIABLE(protected = true )  type: Real unreplaceable
30: $cse82.T:VARIABLE(protected = true )  type: Real unreplaceable
31: $cse82.pd:VARIABLE(protected = true )  type: Real unreplaceable
32: $cse82.vp:VARIABLE(protected = true )  type: Real unreplaceable
33: $cse82.vt:VARIABLE(protected = true )  type: Real unreplaceable
34: $cse82.dpT:VARIABLE(protected = true )  type: Real unreplaceable
35: $cse82.x:VARIABLE(protected = true )  type: Real unreplaceable
36: $cse82.pt:VARIABLE(protected = true )  type: Real unreplaceable
37: $cse82.h:VARIABLE(protected = true )  type: Real unreplaceable
38: $cse82.rho:VARIABLE(protected = true )  type: Real unreplaceable
39: $cse82.phase:DISCRETE(protected = true )  type: Integer unreplaceable
40: $cse82.R_s:VARIABLE(protected = true )  type: Real unreplaceable
41: $cse82.cv:VARIABLE(protected = true )  type: Real unreplaceable
42: $cse82.cp:VARIABLE(protected = true )  type: Real unreplaceable
43: $cse82.p:VARIABLE(protected = true )  type: Real unreplaceable
44: pipeB1B1.flowModel.states[2].p:VARIABLE(min = 611.657 max = 1e8 start = 5e6 unit = \"Pa\" nominal = 1e6 )  \"Pressure\" type: Real [2]
45: V10.dp:VARIABLE(start = 1013.25 unit = \"Pa\" )  \"Pressure difference between port_a and port_b (= port_a.p - port_b.p)\" type: Real
[/var/lib/jenkins1/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/Compiler/BackEnd/BackendDAEUtil.mo:9812:5-9813:77:writable] Error: Internal error BackendDAEUtil.traverseEqSystemStrongComponents failed with function:
omc_DAEMode_traverserStrongComponents
Notification: Performance of <failed> postOpt createDAEmodeBDAE (simulation): time 0.003308/3.142, allocations: 2.833 MB / 1.529 GB, free: 359.7 MB / 0.8731 GB
Error: post-optimization module createDAEmodeBDAE (simulation) failed.
Error: Internal error SimCode DAEmode: The model Modelica.Fluid.Examples.AST_BatchPlant.BatchPlant_StandardWater could not be translated
"
[Timeout remaining time 657]
[Calling sys.exit(0), Time elapsed: 5.2756570630008355]
Failed to read output from testmodel.py, exit status != 0:
['time', 'B5.medium.h', 'B5.level', 'B5.InnerTankTop[1].m_flow_negative', 'B5.InnerTankSide[1].m_flow_negative', 'B5.InnerTankBottom[1].m_flow_negative', 'controller.Transition1.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.Transition10.enableFire', 'controller.Transition11.enableFire', 'controller.Transition12.enableFire', 'controller.Transition13.enableFire', 'controller.TransitionWithSignal1.enableFire', 'volume5.medium.p', 'volume5.medium.h', 'P1.medium.p', 'P1.medium.h', 'P2.medium.p', 'P2.medium.h', 'B1.level', 'B1.medium.h', 'P1_on.y', 'P2_on.y', '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']
3.1511058670002967 3.160632592 1.261431075
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fa6837caf50>