Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.MultiBody.Parts.FreeBodiesEnforceStatesFalse.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.001705/0.001705, allocations: 99.64 kB / 21.25 MB, free: 424 kB / 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.001877/0.001877, allocations: 214.5 kB / 24.55 MB, free: 3.719 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.565/1.565, allocations: 230.5 MB / 258.2 MB, free: 7.727 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.2575/0.2575, allocations: 46.95 MB / 361.7 MB, free: 3.871 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.FreeBodiesEnforceStatesFalse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|body.Q.1.|body.Q.2.|body.Q.3.|body.Q.4.|body.frame_a.r_0.1.|body.frame_a.r_0.2.|body.frame_a.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.frame_a.r_0.1.|bodyBox.body.frame_a.r_0.2.|bodyBox.body.frame_a.r_0.3.|bodyBox.body.w_a.1.|bodyBox.body.w_a.2.|bodyBox.body.w_a.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.frame_a.r_0.1.|bodyCylinder.body.frame_a.r_0.2.|bodyCylinder.body.frame_a.r_0.3.|bodyCylinder.body.w_a.1.|bodyCylinder.body.w_a.2.|bodyCylinder.body.w_a.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.frame_a.r_0.1.|bodyShape.body.frame_a.r_0.2.|bodyShape.body.frame_a.r_0.3.|bodyShape.body.w_a.1.|bodyShape.body.w_a.2.|bodyShape.body.w_a.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.FreeBodiesEnforceStatesFalse")
translateModel(ModelicaTest.MultiBody.Parts.FreeBodiesEnforceStatesFalse,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|body.Q.1.|body.Q.2.|body.Q.3.|body.Q.4.|body.frame_a.r_0.1.|body.frame_a.r_0.2.|body.frame_a.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.frame_a.r_0.1.|bodyBox.body.frame_a.r_0.2.|bodyBox.body.frame_a.r_0.3.|bodyBox.body.w_a.1.|bodyBox.body.w_a.2.|bodyBox.body.w_a.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.frame_a.r_0.1.|bodyCylinder.body.frame_a.r_0.2.|bodyCylinder.body.frame_a.r_0.3.|bodyCylinder.body.w_a.1.|bodyCylinder.body.w_a.2.|bodyCylinder.body.w_a.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.frame_a.r_0.1.|bodyShape.body.frame_a.r_0.2.|bodyShape.body.frame_a.r_0.3.|bodyShape.body.w_a.1.|bodyShape.body.w_a.2.|bodyShape.body.w_a.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.FreeBodiesEnforceStatesFalse") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.511e-05/2.511e-05, allocations: 2.281 kB / 0.4974 GB, free: 7.059 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Parts.FreeBodiesEnforceStatesFalse): time 0.0218/0.02182, allocations: 17.27 MB / 0.5143 GB, free: 5.715 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.3139/0.3357, allocations: 5.786 MB / 0.5199 GB, free: 14.62 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00521/0.3409, allocations: 170.6 kB / 0.5201 GB, free: 14.62 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.01214/0.3531, allocations: 5.807 MB / 0.5258 GB, free: 14.58 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01103/0.3641, allocations: 3.123 MB / 0.5288 GB, free: 14.42 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003896/0.368, allocations: 1.446 MB / 0.5302 GB, free: 14.39 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01826/0.3863, allocations: 10.58 MB / 0.5406 GB, free: 11.69 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.008724/0.395, allocations: 4.328 MB / 0.5448 GB, free: 8.668 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006942/0.4019, allocations: 3.012 MB / 0.5477 GB, free: 7.125 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.008486/0.4104, allocations: 4.268 MB / 0.5519 GB, free: 4.934 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.002241/0.4127, allocations: 435.2 kB / 0.5523 GB, free: 4.93 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.005654/0.4183, allocations: 1.259 MB / 0.5535 GB, free: 4.555 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.01469/0.433, allocations: 9.954 MB / 0.5633 GB, free: 11.78 MB / 398.1 MB
Notification: Performance of replaceArrayConstructors: time 0.008858/0.4419, allocations: 6.101 MB / 0.5692 GB, free: 5.902 MB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.004319/0.4462, allocations: 296 kB / 0.5695 GB, free: 5.613 MB / 398.1 MB
Notification: Performance of FrontEnd: time 0.00177/0.4479, allocations: 158.7 kB / 0.5696 GB, free: 5.457 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.05025/0.4982, allocations: 25.31 MB / 0.5944 GB, free: 12.67 MB / 430.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.006802/0.505, allocations: 3.074 MB / 0.5974 GB, free: 9.402 MB / 430.1 MB
Notification: Performance of [SIM] Early Inline: time 6.086/6.591, allocations: 1.914 GB / 2.512 GB, free: 10.7 MB / 0.7637 GB
Notification: Performance of [SIM] Simplify 1: time 3.576/10.17, allocations: 1.113 GB / 3.625 GB, free: 23.12 MB / 0.9981 GB
Notification: Performance of [SIM] Alias: time 1.893/12.06, allocations: 472.6 MB / 4.086 GB, free: 191.8 MB / 0.9981 GB
Notification: Performance of [SIM] Simplify 2: time 3.302/15.36, allocations: 1.113 GB / 5.199 GB, free: 72.14 MB / 0.9981 GB
Notification: Performance of [SIM] Remove Stream: time 0.2018/15.56, allocations: 69.65 MB / 5.267 GB, free: 67.37 MB / 0.9981 GB
Notification: Performance of [SIM] Detect States: time 1.041/16.61, allocations: 200.4 MB / 5.463 GB, free: 323 MB / 0.9981 GB
Notification: Performance of [SIM] Events: time 1.319/17.92, allocations: 0.5484 GB / 6.011 GB, free: 209.4 MB / 0.9981 GB
Notification: Performance of [SIM] Partitioning: time 0.0919/18.02, allocations: 40.95 MB / 6.051 GB, free: 191.9 MB / 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.12636948697036]
Failed to read output from testmodel.py, exit status != 0:
['time', 'body.Q[1]', 'body.Q[2]', 'body.Q[3]', 'body.Q[4]', 'body.frame_a.r_0[1]', 'body.frame_a.r_0[2]', 'body.frame_a.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.frame_a.r_0[1]', 'bodyBox.body.frame_a.r_0[2]', 'bodyBox.body.frame_a.r_0[3]', 'bodyBox.body.w_a[1]', 'bodyBox.body.w_a[2]', 'bodyBox.body.w_a[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.frame_a.r_0[1]', 'bodyCylinder.body.frame_a.r_0[2]', 'bodyCylinder.body.frame_a.r_0[3]', 'bodyCylinder.body.w_a[1]', 'bodyCylinder.body.w_a[2]', 'bodyCylinder.body.w_a[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.frame_a.r_0[1]', 'bodyShape.body.frame_a.r_0[2]', 'bodyShape.body.frame_a.r_0[3]', 'bodyShape.body.w_a[1]', 'bodyShape.body.w_a[2]', 'bodyShape.body.w_a[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.044964997970965 18.056924441 17.605889002
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f5458712fb0>