Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.MultiBody.Parts.FreeBodies.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo): time 0.001799/0.001799, allocations: 107.6 kB / 21.25 MB, free: 0.5625 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo): time 0.001956/0.001956, allocations: 219.1 kB / 24.55 MB, free: 3.82 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo): time 1.558/1.558, allocations: 230.5 MB / 258.2 MB, free: 7.73 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo): time 0.2436/0.2436, allocations: 46.96 MB / 361.7 MB, free: 3.867 MB / 286.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest trunk/package.mo)
Using package Modelica with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica trunk/package.mo)
Using package Complex with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex trunk/package.mo)
Using package ModelicaServices with version trunk (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices trunk/package.mo)
Running command: translateModel(ModelicaTest.MultiBody.Parts.FreeBodies,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|body.Q.1.|body.Q.2.|body.Q.3.|body.Q.4.|body.r_0.1.|body.r_0.2.|body.r_0.3.|body.v_0.1.|body.v_0.2.|body.v_0.3.|body.w_a.1.|body.w_a.2.|body.w_a.3.|bodyBox.body.Q.1.|bodyBox.body.Q.2.|bodyBox.body.Q.3.|bodyBox.body.Q.4.|bodyBox.body.w_a.1.|bodyBox.body.w_a.2.|bodyBox.body.w_a.3.|bodyBox.r_0.1.|bodyBox.r_0.2.|bodyBox.r_0.3.|bodyBox.v_0.1.|bodyBox.v_0.2.|bodyBox.v_0.3.|bodyCylinder.body.Q.1.|bodyCylinder.body.Q.2.|bodyCylinder.body.Q.3.|bodyCylinder.body.Q.4.|bodyCylinder.body.w_a.1.|bodyCylinder.body.w_a.2.|bodyCylinder.body.w_a.3.|bodyCylinder.r_0.1.|bodyCylinder.r_0.2.|bodyCylinder.r_0.3.|bodyCylinder.v_0.1.|bodyCylinder.v_0.2.|bodyCylinder.v_0.3.|bodyShape.body.Q.1.|bodyShape.body.Q.2.|bodyShape.body.Q.3.|bodyShape.body.Q.4.|bodyShape.body.w_a.1.|bodyShape.body.w_a.2.|bodyShape.body.w_a.3.|bodyShape.r_0.1.|bodyShape.r_0.2.|bodyShape.r_0.3.|bodyShape.v_0.1.|bodyShape.v_0.2.|bodyShape.v_0.3.|pointMass.r_0.1.|pointMass.r_0.2.|pointMass.r_0.3.|pointMass.v_0.1.|pointMass.v_0.2.|pointMass.v_0.3.",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.MultiBody.Parts.FreeBodies")
translateModel(ModelicaTest.MultiBody.Parts.FreeBodies,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|body.Q.1.|body.Q.2.|body.Q.3.|body.Q.4.|body.r_0.1.|body.r_0.2.|body.r_0.3.|body.v_0.1.|body.v_0.2.|body.v_0.3.|body.w_a.1.|body.w_a.2.|body.w_a.3.|bodyBox.body.Q.1.|bodyBox.body.Q.2.|bodyBox.body.Q.3.|bodyBox.body.Q.4.|bodyBox.body.w_a.1.|bodyBox.body.w_a.2.|bodyBox.body.w_a.3.|bodyBox.r_0.1.|bodyBox.r_0.2.|bodyBox.r_0.3.|bodyBox.v_0.1.|bodyBox.v_0.2.|bodyBox.v_0.3.|bodyCylinder.body.Q.1.|bodyCylinder.body.Q.2.|bodyCylinder.body.Q.3.|bodyCylinder.body.Q.4.|bodyCylinder.body.w_a.1.|bodyCylinder.body.w_a.2.|bodyCylinder.body.w_a.3.|bodyCylinder.r_0.1.|bodyCylinder.r_0.2.|bodyCylinder.r_0.3.|bodyCylinder.v_0.1.|bodyCylinder.v_0.2.|bodyCylinder.v_0.3.|bodyShape.body.Q.1.|bodyShape.body.Q.2.|bodyShape.body.Q.3.|bodyShape.body.Q.4.|bodyShape.body.w_a.1.|bodyShape.body.w_a.2.|bodyShape.body.w_a.3.|bodyShape.r_0.1.|bodyShape.r_0.2.|bodyShape.r_0.3.|bodyShape.v_0.1.|bodyShape.v_0.2.|bodyShape.v_0.3.|pointMass.r_0.1.|pointMass.r_0.2.|pointMass.r_0.3.|pointMass.v_0.1.|pointMass.v_0.2.|pointMass.v_0.3.",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.MultiBody.Parts.FreeBodies") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.556e-05/2.556e-05, allocations: 2.281 kB / 0.4974 GB, free: 7.055 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Parts.FreeBodies): time 0.02134/0.02136, allocations: 17.27 MB / 0.5143 GB, free: 5.707 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.3424/0.3638, allocations: 5.779 MB / 0.5199 GB, free: 14.62 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.005555/0.3694, allocations: 171.5 kB / 0.5201 GB, free: 14.62 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.01342/0.3828, allocations: 5.805 MB / 0.5258 GB, free: 14.59 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01252/0.3953, allocations: 3.125 MB / 0.5288 GB, free: 14.43 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00482/0.4001, allocations: 1.454 MB / 0.5302 GB, free: 14.39 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01977/0.4199, allocations: 10.56 MB / 0.5405 GB, free: 11.69 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01049/0.4304, allocations: 4.325 MB / 0.5448 GB, free: 8.664 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.008449/0.4388, allocations: 3.02 MB / 0.5477 GB, free: 7.113 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.008694/0.4475, allocations: 4.26 MB / 0.5519 GB, free: 4.93 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002295/0.4498, allocations: 431.7 kB / 0.5523 GB, free: 4.93 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005857/0.4557, allocations: 1.262 MB / 0.5535 GB, free: 4.551 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.01463/0.4703, allocations: 9.955 MB / 0.5632 GB, free: 11.77 MB / 398.1 MB
Notification: Performance of replaceArrayConstructors: time 0.008446/0.4787, allocations: 6.115 MB / 0.5692 GB, free: 5.879 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002961/0.4817, allocations: 296 kB / 0.5695 GB, free: 5.59 MB / 398.1 MB
Notification: Performance of FrontEnd: time 0.001518/0.4832, allocations: 154.8 kB / 0.5696 GB, free: 5.438 MB / 398.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2624 (990)
 * Number of variables: 2624 (863)
Notification: Performance of [SIM] Bindings: time 0.04706/0.5303, allocations: 25.37 MB / 0.5944 GB, free: 12.57 MB / 430.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.007213/0.5375, allocations: 3.093 MB / 0.5974 GB, free: 9.285 MB / 430.1 MB
Notification: Performance of [SIM] Early Inline: time 6.255/6.792, allocations: 1.914 GB / 2.512 GB, free: 13.43 MB / 0.7637 GB
Notification: Performance of [SIM] Simplify 1: time 3.432/10.22, allocations: 1.113 GB / 3.625 GB, free: 11.59 MB / 0.9981 GB
Notification: Performance of [SIM] Alias: time 1.87/12.09, allocations: 472.6 MB / 4.086 GB, free: 127.8 MB / 0.9981 GB
Notification: Performance of [SIM] Simplify 2: time 3.398/15.49, allocations: 1.113 GB / 5.199 GB, free: 32.32 MB / 0.9981 GB
Notification: Performance of [SIM] Remove Stream: time 0.1879/15.68, allocations: 69.65 MB / 5.267 GB, free: 27.24 MB / 0.9981 GB
Notification: Performance of [SIM] Detect States: time 1.053/16.73, allocations: 200.3 MB / 5.463 GB, free: 276 MB / 0.9981 GB
Notification: Performance of [SIM] Events: time 1.219/17.95, allocations: 0.5485 GB / 6.011 GB, free: 95.65 MB / 0.9981 GB
Notification: Performance of [SIM] Partitioning: time 0.4977/18.45, allocations: 41.16 MB / 6.051 GB, free: 0.5431 GB / 0.9981 GB
Error: Internal error NBResolveSingularities.indexReduction failed because slicing during index reduction is not yet supported.
  needed sliced dummy:		[STAT] (4) protected Real[4] bodyBox.body.Q (start = bodyBox.body.Q_start, StateSelect = avoid)
	slice: {3}
"
[Timeout remaining time 642]
[Calling sys.exit(0), Time elapsed: 21.476952318975236]
Failed to read output from testmodel.py, exit status != 0:
['time', 'body.Q[1]', 'body.Q[2]', 'body.Q[3]', 'body.Q[4]', 'body.r_0[1]', 'body.r_0[2]', 'body.r_0[3]', 'body.v_0[1]', 'body.v_0[2]', 'body.v_0[3]', 'body.w_a[1]', 'body.w_a[2]', 'body.w_a[3]', 'bodyBox.body.Q[1]', 'bodyBox.body.Q[2]', 'bodyBox.body.Q[3]', 'bodyBox.body.Q[4]', 'bodyBox.body.w_a[1]', 'bodyBox.body.w_a[2]', 'bodyBox.body.w_a[3]', 'bodyBox.r_0[1]', 'bodyBox.r_0[2]', 'bodyBox.r_0[3]', 'bodyBox.v_0[1]', 'bodyBox.v_0[2]', 'bodyBox.v_0[3]', 'bodyCylinder.body.Q[1]', 'bodyCylinder.body.Q[2]', 'bodyCylinder.body.Q[3]', 'bodyCylinder.body.Q[4]', 'bodyCylinder.body.w_a[1]', 'bodyCylinder.body.w_a[2]', 'bodyCylinder.body.w_a[3]', 'bodyCylinder.r_0[1]', 'bodyCylinder.r_0[2]', 'bodyCylinder.r_0[3]', 'bodyCylinder.v_0[1]', 'bodyCylinder.v_0[2]', 'bodyCylinder.v_0[3]', 'bodyShape.body.Q[1]', 'bodyShape.body.Q[2]', 'bodyShape.body.Q[3]', 'bodyShape.body.Q[4]', 'bodyShape.body.w_a[1]', 'bodyShape.body.w_a[2]', 'bodyShape.body.w_a[3]', 'bodyShape.r_0[1]', 'bodyShape.r_0[2]', 'bodyShape.r_0[3]', 'bodyShape.v_0[1]', 'bodyShape.v_0[2]', 'bodyShape.v_0[3]', 'pointMass.r_0[1]', 'pointMass.r_0[2]', 'pointMass.r_0[3]', 'pointMass.v_0[1]', 'pointMass.v_0[2]', 'pointMass.v_0[3]']
18.482823449012358 18.493410637 18.007359635
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fca70beafb0>