Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.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.001736/0.001736, allocations: 107 kB / 21.23 MB, free: 0.6406 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.002127/0.002127, allocations: 210 kB / 24.53 MB, free: 3.941 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.577/1.577, allocations: 230.6 MB / 258.3 MB, free: 7.828 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: writeFile("Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.mo", OpenModelica.Scripting.instantiateModel(Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2))
writeFile("Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.mo", OpenModelica.Scripting.instantiateModel(Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2)) [Timeout 660]
"Notification: Performance of FrontEnd - loaded program: time 0.001676/0.001676, allocations: 47.94 kB / 378.5 MB, free: 3.094 MB / 302.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.322/0.3237, allocations: 53.36 MB / 431.9 MB, free: 6.688 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2): time 0.04157/0.3652, allocations: 33.88 MB / 465.7 MB, free: 4.684 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.02444/0.3897, allocations: 13.7 MB / 479.4 MB, free: 6.949 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002737/0.3924, allocations: 158.6 kB / 479.6 MB, free: 6.793 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.002715/0.3951, allocations: 0.6676 MB / 480.3 MB, free: 6.121 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.008337/0.4035, allocations: 2.652 MB / 482.9 MB, free: 3.457 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.01069/0.4142, allocations: 3.948 MB / 486.9 MB, free: 15.52 MB / 398.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007933/0.4221, allocations: 4.931 MB / 491.8 MB, free: 10.57 MB / 398.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002589/0.4247, allocations: 1.089 MB / 492.9 MB, free: 9.461 MB / 398.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.005477/0.4302, allocations: 2.045 MB / 494.9 MB, free: 7.41 MB / 398.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004991/0.4351, allocations: 1.767 MB / 496.7 MB, free: 5.637 MB / 398.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000884/0.436, allocations: 148 kB / 496.8 MB, free: 5.492 MB / 398.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.006246/0.4423, allocations: 1.931 MB / 498.8 MB, free: 3.559 MB / 398.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.001559/0.4438, allocations: 0.6153 MB / 499.4 MB, free: 2.941 MB / 398.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.008723/0.4526, allocations: 3.393 MB / 0.491 GB, free: 15.61 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 1.239e-05/0.4526, allocations: 0 / 0.491 GB, free: 15.61 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 1.923e-06/0.4526, allocations: 0 / 0.491 GB, free: 15.61 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001134/0.4527, allocations: 82.39 kB / 0.4911 GB, free: 15.54 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.14e-06/0.4527, allocations: 0 / 0.4911 GB, free: 15.54 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 6.31e-07/0.4527, allocations: 4 kB / 0.4911 GB, free: 15.53 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.375e-05/0.4528, allocations: 72.59 kB / 0.4912 GB, free: 15.46 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 4.92e-06/0.4528, allocations: 0 / 0.4912 GB, free: 15.46 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.21e-07/0.4528, allocations: 3.938 kB / 0.4912 GB, free: 15.46 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.962e-05/0.4529, allocations: 75.75 kB / 0.4912 GB, free: 15.39 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 7.354e-06/0.4529, allocations: 11.88 kB / 0.4912 GB, free: 15.38 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.11e-07/0.4529, allocations: 0 / 0.4912 GB, free: 15.38 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.395e-05/0.453, allocations: 72.66 kB / 0.4913 GB, free: 15.3 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 8.115e-06/0.453, allocations: 3.938 kB / 0.4913 GB, free: 15.3 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.01e-07/0.453, allocations: 0 / 0.4913 GB, free: 15.3 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.0001065/0.4531, allocations: 75.84 kB / 0.4914 GB, free: 15.23 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 8.125e-06/0.4531, allocations: 3.938 kB / 0.4914 GB, free: 15.22 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.01e-07/0.4531, allocations: 0 / 0.4914 GB, free: 15.22 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.226e-05/0.4532, allocations: 67.84 kB / 0.4915 GB, free: 15.16 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 9.297e-06/0.4532, allocations: 7.938 kB / 0.4915 GB, free: 15.15 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.91e-07/0.4532, allocations: 0 / 0.4915 GB, free: 15.15 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.325e-05/0.4533, allocations: 87.5 kB / 0.4915 GB, free: 15.06 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.019e-06/0.4533, allocations: 3.938 kB / 0.4916 GB, free: 15.06 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.01e-07/0.4533, allocations: 0 / 0.4916 GB, free: 15.06 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.64e-05/0.4534, allocations: 75.78 kB / 0.4916 GB, free: 14.98 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 4.96e-06/0.4534, allocations: 4 kB / 0.4916 GB, free: 14.98 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.01e-07/0.4534, allocations: 0 / 0.4916 GB, free: 14.98 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.106e-05/0.4535, allocations: 75.72 kB / 0.4917 GB, free: 14.91 MB / 414.1 MB
Notification: Performance of NFTyping.typeBindings: time 4.849e-06/0.4535, allocations: 4 kB / 0.4917 GB, free: 14.9 MB / 414.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.91e-07/0.4535, allocations: 0 / 0.4917 GB, free: 14.9 MB / 414.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.007522/0.461, allocations: 4.087 MB / 0.4957 GB, free: 10.89 MB / 414.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.009027/0.4701, allocations: 3.854 MB / 0.4995 GB, free: 7.02 MB / 414.1 MB
Notification: Performance of FrontEnd - DAE generated: time 7.584e-06/0.4701, allocations: 0 / 0.4995 GB, free: 7.02 MB / 414.1 MB
Notification: Performance of runFrontEnd: time 1.473e-06/0.4701, allocations: 4 kB / 0.4995 GB, free: 7.016 MB / 414.1 MB
Notification: Performance of FrontEnd - loaded program: time 0.001704/0.001704, allocations: 51.91 kB / 0.4995 GB, free: 6.965 MB / 414.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3496/0.3513, allocations: 53.34 MB / 0.5516 GB, free: 111.1 MB / 446.1 MB
Notification: Performance of NFInst.instantiate(Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2): time 0.03159/0.3828, allocations: 33.89 MB / 0.5847 GB, free: 86.77 MB / 446.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01737/0.4002, allocations: 13.7 MB / 0.5981 GB, free: 74.47 MB / 446.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002665/0.4029, allocations: 154.6 kB / 0.5982 GB, free: 74.32 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.001806/0.4047, allocations: 0.6715 MB / 0.5989 GB, free: 73.64 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00657/0.4113, allocations: 2.64 MB / 0.6015 GB, free: 70.99 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00953/0.4208, allocations: 3.953 MB / 0.6053 GB, free: 67.05 MB / 446.1 MB
Notification: Performance of NFFlatten.flatten: time 0.006221/0.427, allocations: 4.935 MB / 0.6101 GB, free: 62.1 MB / 446.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.001797/0.4288, allocations: 1.085 MB / 0.6112 GB, free: 60.99 MB / 446.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004145/0.4329, allocations: 2.041 MB / 0.6132 GB, free: 58.95 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.00274/0.4357, allocations: 1.775 MB / 0.6149 GB, free: 57.16 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0003717/0.4361, allocations: 144 kB / 0.6151 GB, free: 57.02 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00425/0.4403, allocations: 1.935 MB / 0.6169 GB, free: 55.09 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.0006942/0.441, allocations: 0.6114 MB / 0.6175 GB, free: 54.47 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.005886/0.4469, allocations: 3.402 MB / 0.6209 GB, free: 51.15 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 1.077e-05/0.4469, allocations: 0 / 0.6209 GB, free: 51.15 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 2.104e-06/0.4469, allocations: 3.938 kB / 0.6209 GB, free: 51.14 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 7.323e-05/0.447, allocations: 75.8 kB / 0.6209 GB, free: 51.07 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.731e-06/0.447, allocations: 7.938 kB / 0.6209 GB, free: 51.06 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.91e-07/0.447, allocations: 0 / 0.6209 GB, free: 51.06 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 6.452e-05/0.447, allocations: 68.66 kB / 0.621 GB, free: 51 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.911e-06/0.4471, allocations: 7.938 kB / 0.621 GB, free: 50.99 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.51e-07/0.4471, allocations: 0 / 0.621 GB, free: 50.99 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 6.026e-05/0.4471, allocations: 75.83 kB / 0.6211 GB, free: 50.92 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.541e-06/0.4471, allocations: 3.938 kB / 0.6211 GB, free: 50.91 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 1.363e-06/0.4471, allocations: 4 kB / 0.6211 GB, free: 50.91 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 5.925e-05/0.4472, allocations: 72.66 kB / 0.6212 GB, free: 50.84 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.51e-06/0.4472, allocations: 3.938 kB / 0.6212 GB, free: 50.84 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.61e-07/0.4472, allocations: 0 / 0.6212 GB, free: 50.84 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 5.898e-05/0.4472, allocations: 83.61 kB / 0.6213 GB, free: 50.75 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 4.639e-06/0.4472, allocations: 3.938 kB / 0.6213 GB, free: 50.75 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.51e-07/0.4472, allocations: 0 / 0.6213 GB, free: 50.75 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 5.807e-05/0.4473, allocations: 71.78 kB / 0.6213 GB, free: 50.68 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 4.518e-06/0.4473, allocations: 4 kB / 0.6213 GB, free: 50.68 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.21e-07/0.4473, allocations: 0 / 0.6213 GB, free: 50.68 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 5.823e-05/0.4474, allocations: 79.72 kB / 0.6214 GB, free: 50.6 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 4.709e-06/0.4474, allocations: 0 / 0.6214 GB, free: 50.6 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.61e-07/0.4474, allocations: 0 / 0.6214 GB, free: 50.6 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 9.43e-05/0.4475, allocations: 79.78 kB / 0.6215 GB, free: 50.52 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.01e-06/0.4475, allocations: 0 / 0.6215 GB, free: 50.52 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 5.21e-07/0.4475, allocations: 0 / 0.6215 GB, free: 50.52 MB / 446.1 MB
Notification: Performance of NFTyping.typeComponents: time 5.722e-05/0.4475, allocations: 75.72 kB / 0.6216 GB, free: 50.45 MB / 446.1 MB
Notification: Performance of NFTyping.typeBindings: time 5.34e-06/0.4475, allocations: 4 kB / 0.6216 GB, free: 50.44 MB / 446.1 MB
Notification: Performance of NFTyping.typeClassSections: time 4.3e-07/0.4475, allocations: 0 / 0.6216 GB, free: 50.44 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.006341/0.4539, allocations: 4.076 MB / 0.6255 GB, free: 46.45 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.008857/0.4627, allocations: 3.858 MB / 0.6293 GB, free: 42.58 MB / 446.1 MB
Notification: Performance of FrontEnd - DAE generated: time 6.302e-06/0.4627, allocations: 0 / 0.6293 GB, free: 42.58 MB / 446.1 MB
Notification: Performance of runFrontEnd: time 1.853e-06/0.4627, allocations: 4 kB / 0.6293 GB, free: 42.57 MB / 446.1 MB
"
[Timeout remaining time 659]
(rm -f Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.pipe ; mkfifo Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.pipe ; head -c 1048576 < Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.pipe >> ../files/Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.sim & /usr/bin/julia Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2_test.jl > Modelica_4.1.0_Modelica.Fluid.Examples.AST_BatchPlant.Test.TanksWithEmptyingPipe2.pipe 2>&1) [Timeout 504.0]
[Calling os._exit(0), Time elapsed: 35.24687563814223]
Failed to read output from testmodel.py, exit status != 0:
['time', 'tank1.level', 'tank1.medium.T', 'tank2.level', 'tank2.medium.T', 'tank3.level', 'tank3.medium.T', 'tank1.aboveLevel[1]', 'tank2.aboveLevel[1]', 'tank2.aboveLevel[2]', 'tank2.aboveLevel[3]', 'tank3.aboveLevel[1]', 'tank3.aboveLevel[2]']
0.9426078149117529 -1.0 -1.0
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7ff0a9502f20>