Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_3.2.3_ModelicaTest.MultiBody.Joints.JointUSP.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.001753/0.001753, allocations: 100.4 kB / 20.52 MB, free: 1.148 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.001863/0.001863, allocations: 213.8 kB / 23.82 MB, free: 4.344 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+maint.om/package.mo): time 1.72/1.72, allocations: 207.7 MB / 234.7 MB, free: 9.742 MB / 190.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo): time 0.2403/0.2403, allocations: 44.26 MB / 331.2 MB, free: 9.27 MB / 270.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.3+maint.om/package.mo)
Using package Modelica with version 3.2.3 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.3+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(ModelicaTest.MultiBody.Joints.JointUSP,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|rRod1_ia.1.|rRod1_ia.2.|rRod1_ia.3.|rRod2_ib.1.|rRod2_ib.2.|rRod2_ib.3.|Fixed1.frame_b.r_0.1.|Fixed1.frame_b.r_0.2.|Fixed1.frame_b.r_0.3.|Fixed1.frame_b.f.1.|Fixed1.frame_b.f.2.|Fixed1.frame_b.f.3.|Fixed1.frame_b.t.1.|Fixed1.frame_b.t.2.|Fixed1.frame_b.t.3.|jointUSP.frame_b.r_0.1.|jointUSP.frame_b.r_0.2.|jointUSP.frame_b.r_0.3.|jointUSP.frame_b.f.1.|jointUSP.frame_b.f.2.|jointUSP.frame_b.f.3.|jointUSP.frame_b.t.1.|jointUSP.frame_b.t.2.|jointUSP.frame_b.t.3.|jointUSP.frame_ia.r_0.1.|jointUSP.frame_ia.r_0.2.|jointUSP.frame_ia.r_0.3.|jointUSP.frame_ia.f.1.|jointUSP.frame_ia.f.2.|jointUSP.frame_ia.f.3.|jointUSP.frame_ia.t.1.|jointUSP.frame_ia.t.2.|jointUSP.frame_ia.t.3.|jointUSP.frame_im.r_0.1.|jointUSP.frame_im.r_0.1.|jointUSP.frame_im.r_0.2.|jointUSP.frame_im.r_0.2.|jointUSP.frame_im.r_0.3.|jointUSP.frame_im.r_0.3.|jointUSP.frame_im.f.1.|jointUSP.frame_im.f.1.|jointUSP.frame_im.f.2.|jointUSP.frame_im.f.2.|jointUSP.frame_im.f.3.|jointUSP.frame_im.f.3.|jointUSP.frame_im.t.1.|jointUSP.frame_im.t.1.|jointUSP.frame_im.t.2.|jointUSP.frame_im.t.2.|jointUSP.frame_im.t.3.|jointUSP.frame_im.t.3.|jointUSP.prismatic.frame_b.r_0.1.|jointUSP.prismatic.frame_b.r_0.2.|jointUSP.prismatic.frame_b.r_0.3.|jointUSP.prismatic.frame_b.f.1.|jointUSP.prismatic.frame_b.f.2.|jointUSP.prismatic.frame_b.f.3.|jointUSP.prismatic.frame_b.t.1.|jointUSP.prismatic.frame_b.t.2.|jointUSP.prismatic.frame_b.t.3.|jointUSP.rod1.frame_b.r_0.1.|jointUSP.rod1.frame_b.r_0.2.|jointUSP.rod1.frame_b.r_0.3.|jointUSP.rod1.frame_b.f.1.|jointUSP.rod1.frame_b.f.2.|jointUSP.rod1.frame_b.f.3.|jointUSP.rod1.frame_b.t.1.|jointUSP.rod1.frame_b.t.2.|jointUSP.rod1.frame_b.t.3.|jointUSP.rod1.frame_ia.r_0.1.|jointUSP.rod1.frame_ia.r_0.2.|jointUSP.rod1.frame_ia.r_0.3.|jointUSP.rod1.frame_ia.f.1.|jointUSP.rod1.frame_ia.f.2.|jointUSP.rod1.frame_ia.f.3.|jointUSP.rod1.frame_ia.t.1.|jointUSP.rod1.frame_ia.t.2.|jointUSP.rod1.frame_ia.t.3.|jointUSP.rod2.frame_b.r_0.1.|jointUSP.rod2.frame_b.r_0.2.|jointUSP.rod2.frame_b.r_0.3.|jointUSP.rod2.frame_b.f.1.|jointUSP.rod2.frame_b.f.2.|jointUSP.rod2.frame_b.f.3.|jointUSP.rod2.frame_b.t.1.|jointUSP.rod2.frame_b.t.2.|jointUSP.rod2.frame_b.t.3.|jointUSP.relativePosition.frame_b.r_0.1.|jointUSP.relativePosition.frame_b.r_0.2.|jointUSP.relativePosition.frame_b.r_0.3.|jointUSP.relativePosition.frame_b.f.1.|jointUSP.relativePosition.frame_b.f.2.|jointUSP.relativePosition.frame_b.f.3.|jointUSP.relativePosition.frame_b.t.1.|jointUSP.relativePosition.frame_b.t.2.|jointUSP.relativePosition.frame_b.t.3.|jointUSP.relativePosition.relativePosition.frame_b.r_0.1.|jointUSP.relativePosition.relativePosition.frame_b.r_0.2.|jointUSP.relativePosition.relativePosition.frame_b.r_0.3.|jointUSP.relativePosition.relativePosition.frame_b.f.1.|jointUSP.relativePosition.relativePosition.frame_b.f.2.|jointUSP.relativePosition.relativePosition.frame_b.f.3.|jointUSP.relativePosition.relativePosition.frame_b.t.1.|jointUSP.relativePosition.relativePosition.frame_b.t.2.|jointUSP.relativePosition.relativePosition.frame_b.t.3.|jointUSP.position_b.1..y|jointUSP.position_b.2..y|jointUSP.position_b.3..y",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.MultiBody.Joints.JointUSP")
translateModel(ModelicaTest.MultiBody.Joints.JointUSP,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|rRod1_ia.1.|rRod1_ia.2.|rRod1_ia.3.|rRod2_ib.1.|rRod2_ib.2.|rRod2_ib.3.|Fixed1.frame_b.r_0.1.|Fixed1.frame_b.r_0.2.|Fixed1.frame_b.r_0.3.|Fixed1.frame_b.f.1.|Fixed1.frame_b.f.2.|Fixed1.frame_b.f.3.|Fixed1.frame_b.t.1.|Fixed1.frame_b.t.2.|Fixed1.frame_b.t.3.|jointUSP.frame_b.r_0.1.|jointUSP.frame_b.r_0.2.|jointUSP.frame_b.r_0.3.|jointUSP.frame_b.f.1.|jointUSP.frame_b.f.2.|jointUSP.frame_b.f.3.|jointUSP.frame_b.t.1.|jointUSP.frame_b.t.2.|jointUSP.frame_b.t.3.|jointUSP.frame_ia.r_0.1.|jointUSP.frame_ia.r_0.2.|jointUSP.frame_ia.r_0.3.|jointUSP.frame_ia.f.1.|jointUSP.frame_ia.f.2.|jointUSP.frame_ia.f.3.|jointUSP.frame_ia.t.1.|jointUSP.frame_ia.t.2.|jointUSP.frame_ia.t.3.|jointUSP.frame_im.r_0.1.|jointUSP.frame_im.r_0.1.|jointUSP.frame_im.r_0.2.|jointUSP.frame_im.r_0.2.|jointUSP.frame_im.r_0.3.|jointUSP.frame_im.r_0.3.|jointUSP.frame_im.f.1.|jointUSP.frame_im.f.1.|jointUSP.frame_im.f.2.|jointUSP.frame_im.f.2.|jointUSP.frame_im.f.3.|jointUSP.frame_im.f.3.|jointUSP.frame_im.t.1.|jointUSP.frame_im.t.1.|jointUSP.frame_im.t.2.|jointUSP.frame_im.t.2.|jointUSP.frame_im.t.3.|jointUSP.frame_im.t.3.|jointUSP.prismatic.frame_b.r_0.1.|jointUSP.prismatic.frame_b.r_0.2.|jointUSP.prismatic.frame_b.r_0.3.|jointUSP.prismatic.frame_b.f.1.|jointUSP.prismatic.frame_b.f.2.|jointUSP.prismatic.frame_b.f.3.|jointUSP.prismatic.frame_b.t.1.|jointUSP.prismatic.frame_b.t.2.|jointUSP.prismatic.frame_b.t.3.|jointUSP.rod1.frame_b.r_0.1.|jointUSP.rod1.frame_b.r_0.2.|jointUSP.rod1.frame_b.r_0.3.|jointUSP.rod1.frame_b.f.1.|jointUSP.rod1.frame_b.f.2.|jointUSP.rod1.frame_b.f.3.|jointUSP.rod1.frame_b.t.1.|jointUSP.rod1.frame_b.t.2.|jointUSP.rod1.frame_b.t.3.|jointUSP.rod1.frame_ia.r_0.1.|jointUSP.rod1.frame_ia.r_0.2.|jointUSP.rod1.frame_ia.r_0.3.|jointUSP.rod1.frame_ia.f.1.|jointUSP.rod1.frame_ia.f.2.|jointUSP.rod1.frame_ia.f.3.|jointUSP.rod1.frame_ia.t.1.|jointUSP.rod1.frame_ia.t.2.|jointUSP.rod1.frame_ia.t.3.|jointUSP.rod2.frame_b.r_0.1.|jointUSP.rod2.frame_b.r_0.2.|jointUSP.rod2.frame_b.r_0.3.|jointUSP.rod2.frame_b.f.1.|jointUSP.rod2.frame_b.f.2.|jointUSP.rod2.frame_b.f.3.|jointUSP.rod2.frame_b.t.1.|jointUSP.rod2.frame_b.t.2.|jointUSP.rod2.frame_b.t.3.|jointUSP.relativePosition.frame_b.r_0.1.|jointUSP.relativePosition.frame_b.r_0.2.|jointUSP.relativePosition.frame_b.r_0.3.|jointUSP.relativePosition.frame_b.f.1.|jointUSP.relativePosition.frame_b.f.2.|jointUSP.relativePosition.frame_b.f.3.|jointUSP.relativePosition.frame_b.t.1.|jointUSP.relativePosition.frame_b.t.2.|jointUSP.relativePosition.frame_b.t.3.|jointUSP.relativePosition.relativePosition.frame_b.r_0.1.|jointUSP.relativePosition.relativePosition.frame_b.r_0.2.|jointUSP.relativePosition.relativePosition.frame_b.r_0.3.|jointUSP.relativePosition.relativePosition.frame_b.f.1.|jointUSP.relativePosition.relativePosition.frame_b.f.2.|jointUSP.relativePosition.relativePosition.frame_b.f.3.|jointUSP.relativePosition.relativePosition.frame_b.t.1.|jointUSP.relativePosition.relativePosition.frame_b.t.2.|jointUSP.relativePosition.relativePosition.frame_b.t.3.|jointUSP.position_b.1..y|jointUSP.position_b.2..y|jointUSP.position_b.3..y",fileNamePrefix="ModelicaTest_3.2.3_ModelicaTest.MultiBody.Joints.JointUSP") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.475e-05/2.475e-05, allocations: 5.656 kB / 468.8 MB, free: 3.82 MB / 334.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.JointUSP): time 0.01498/0.015, allocations: 10.99 MB / 479.8 MB, free: 8.77 MB / 350.1 MB
Notification: Performance of NFInst.instExpressions: time 0.008858/0.02386, allocations: 3.412 MB / 483.2 MB, free: 5.348 MB / 350.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00242/0.02628, allocations: 75.69 kB / 483.3 MB, free: 5.273 MB / 350.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006942/0.03322, allocations: 3.228 MB / 486.5 MB, free: 2.035 MB / 350.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.003624/0.03684, allocations: 0.999 MB / 487.5 MB, free: 1.031 MB / 350.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00213/0.03897, allocations: 0.6655 MB / 488.2 MB, free: 376 kB / 350.1 MB
Notification: Performance of NFFlatten.flatten: time 0.005226/0.0442, allocations: 2.899 MB / 491.1 MB, free: 13.46 MB / 366.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004672/0.04887, allocations: 2.421 MB / 493.5 MB, free: 10.99 MB / 366.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.00328/0.05215, allocations: 1.355 MB / 494.9 MB, free: 9.629 MB / 366.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.003149/0.0553, allocations: 1.373 MB / 496.3 MB, free: 8.25 MB / 366.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.0009193/0.05622, allocations: 252 kB / 496.5 MB, free: 8.004 MB / 366.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002229/0.05845, allocations: 0.6866 MB / 497.2 MB, free: 7.316 MB / 366.1 MB
Notification: Performance of combineBinaries: time 0.00643/0.06488, allocations: 4.501 MB / 0.4899 GB, free: 2.777 MB / 366.1 MB
Notification: Performance of replaceArrayConstructors: time 0.003524/0.06841, allocations: 2.742 MB / 0.4926 GB, free: 4 kB / 366.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001239/0.06964, allocations: 144 kB / 0.4928 GB, free: 15.86 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.0005396/0.07018, allocations: 83.25 kB / 0.4928 GB, free: 15.78 MB / 382.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1292 (607)
 * Number of variables: 1292 (436)
Notification: Performance of [SIM] Bindings: time 0.01855/0.08873, allocations: 12.35 MB / 0.5049 GB, free: 3.105 MB / 382.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.003494/0.09223, allocations: 1.724 MB / 0.5066 GB, free: 1.281 MB / 382.1 MB
Notification: Performance of [SIM] Early Inline: time 0.01607/0.1083, allocations: 9.808 MB / 0.5161 GB, free: 7.375 MB / 398.1 MB
Notification: Performance of [SIM] Simplify 1: time 0.004456/0.1128, allocations: 1.314 MB / 0.5174 GB, free: 5.93 MB / 398.1 MB
Notification: Performance of [SIM] Alias: time 0.01956/0.1323, allocations: 10.26 MB / 0.5274 GB, free: 10.71 MB / 414.1 MB
Notification: Performance of [SIM] Simplify 2: time 0.002196/0.1345, allocations: 1.109 MB / 0.5285 GB, free: 9.477 MB / 414.1 MB
Notification: Performance of [SIM] Remove Stream: time 0.00108/0.1356, allocations: 0.7494 MB / 0.5293 GB, free: 8.629 MB / 414.1 MB
Notification: Performance of [SIM] Detect States: time 0.002055/0.1377, allocations: 1.492 MB / 0.5307 GB, free: 7.074 MB / 414.1 MB
Notification: Performance of [SIM] Events: time 0.0008896/0.1385, allocations: 328.5 kB / 0.531 GB, free: 6.742 MB / 414.1 MB
Notification: Performance of [SIM] Partitioning: time 0.004758/0.1433, allocations: 3.559 MB / 0.5345 GB, free: 2.781 MB / 414.1 MB
Error: Internal error NBResolveSingularities.indexReduction failed because slicing during index reduction is not yet supported.
  needed sliced dummy:		[STAT] (9) Real[3, 3] jointUSP.frame_im.R.T
	slice: {0, 2, 4, 6, 8}
"
[Timeout remaining time 660]
[Calling sys.exit(0), Time elapsed: 3.620399175968487]
Failed to read output from testmodel.py, exit status != 0:
['time', 'rRod1_ia[1]', 'rRod1_ia[2]', 'rRod1_ia[3]', 'rRod2_ib[1]', 'rRod2_ib[2]', 'rRod2_ib[3]', 'Fixed1.frame_b.r_0[1]', 'Fixed1.frame_b.r_0[2]', 'Fixed1.frame_b.r_0[3]', 'Fixed1.frame_b.f[1]', 'Fixed1.frame_b.f[2]', 'Fixed1.frame_b.f[3]', 'Fixed1.frame_b.t[1]', 'Fixed1.frame_b.t[2]', 'Fixed1.frame_b.t[3]', 'jointUSP.frame_b.r_0[1]', 'jointUSP.frame_b.r_0[2]', 'jointUSP.frame_b.r_0[3]', 'jointUSP.frame_b.f[1]', 'jointUSP.frame_b.f[2]', 'jointUSP.frame_b.f[3]', 'jointUSP.frame_b.t[1]', 'jointUSP.frame_b.t[2]', 'jointUSP.frame_b.t[3]', 'jointUSP.frame_ia.r_0[1]', 'jointUSP.frame_ia.r_0[2]', 'jointUSP.frame_ia.r_0[3]', 'jointUSP.frame_ia.f[1]', 'jointUSP.frame_ia.f[2]', 'jointUSP.frame_ia.f[3]', 'jointUSP.frame_ia.t[1]', 'jointUSP.frame_ia.t[2]', 'jointUSP.frame_ia.t[3]', 'jointUSP.frame_im.r_0[1]', 'jointUSP.frame_im.r_0[1]', 'jointUSP.frame_im.r_0[2]', 'jointUSP.frame_im.r_0[2]', 'jointUSP.frame_im.r_0[3]', 'jointUSP.frame_im.r_0[3]', 'jointUSP.frame_im.f[1]', 'jointUSP.frame_im.f[1]', 'jointUSP.frame_im.f[2]', 'jointUSP.frame_im.f[2]', 'jointUSP.frame_im.f[3]', 'jointUSP.frame_im.f[3]', 'jointUSP.frame_im.t[1]', 'jointUSP.frame_im.t[1]', 'jointUSP.frame_im.t[2]', 'jointUSP.frame_im.t[2]', 'jointUSP.frame_im.t[3]', 'jointUSP.frame_im.t[3]', 'jointUSP.prismatic.frame_b.r_0[1]', 'jointUSP.prismatic.frame_b.r_0[2]', 'jointUSP.prismatic.frame_b.r_0[3]', 'jointUSP.prismatic.frame_b.f[1]', 'jointUSP.prismatic.frame_b.f[2]', 'jointUSP.prismatic.frame_b.f[3]', 'jointUSP.prismatic.frame_b.t[1]', 'jointUSP.prismatic.frame_b.t[2]', 'jointUSP.prismatic.frame_b.t[3]', 'jointUSP.rod1.frame_b.r_0[1]', 'jointUSP.rod1.frame_b.r_0[2]', 'jointUSP.rod1.frame_b.r_0[3]', 'jointUSP.rod1.frame_b.f[1]', 'jointUSP.rod1.frame_b.f[2]', 'jointUSP.rod1.frame_b.f[3]', 'jointUSP.rod1.frame_b.t[1]', 'jointUSP.rod1.frame_b.t[2]', 'jointUSP.rod1.frame_b.t[3]', 'jointUSP.rod1.frame_ia.r_0[1]', 'jointUSP.rod1.frame_ia.r_0[2]', 'jointUSP.rod1.frame_ia.r_0[3]', 'jointUSP.rod1.frame_ia.f[1]', 'jointUSP.rod1.frame_ia.f[2]', 'jointUSP.rod1.frame_ia.f[3]', 'jointUSP.rod1.frame_ia.t[1]', 'jointUSP.rod1.frame_ia.t[2]', 'jointUSP.rod1.frame_ia.t[3]', 'jointUSP.rod2.frame_b.r_0[1]', 'jointUSP.rod2.frame_b.r_0[2]', 'jointUSP.rod2.frame_b.r_0[3]', 'jointUSP.rod2.frame_b.f[1]', 'jointUSP.rod2.frame_b.f[2]', 'jointUSP.rod2.frame_b.f[3]', 'jointUSP.rod2.frame_b.t[1]', 'jointUSP.rod2.frame_b.t[2]', 'jointUSP.rod2.frame_b.t[3]', 'jointUSP.relativePosition.frame_b.r_0[1]', 'jointUSP.relativePosition.frame_b.r_0[2]', 'jointUSP.relativePosition.frame_b.r_0[3]', 'jointUSP.relativePosition.frame_b.f[1]', 'jointUSP.relativePosition.frame_b.f[2]', 'jointUSP.relativePosition.frame_b.f[3]', 'jointUSP.relativePosition.frame_b.t[1]', 'jointUSP.relativePosition.frame_b.t[2]', 'jointUSP.relativePosition.frame_b.t[3]', 'jointUSP.relativePosition.relativePosition.frame_b.r_0[1]', 'jointUSP.relativePosition.relativePosition.frame_b.r_0[2]', 'jointUSP.relativePosition.relativePosition.frame_b.r_0[3]', 'jointUSP.relativePosition.relativePosition.frame_b.f[1]', 'jointUSP.relativePosition.relativePosition.frame_b.f[2]', 'jointUSP.relativePosition.relativePosition.frame_b.f[3]', 'jointUSP.relativePosition.relativePosition.frame_b.t[1]', 'jointUSP.relativePosition.relativePosition.frame_b.t[2]', 'jointUSP.relativePosition.relativePosition.frame_b.t[3]', 'jointUSP.position_b[1].y', 'jointUSP.position_b[2].y', 'jointUSP.position_b[3].y']
0.4580082969623618 0.46802624099999995 0.395375875
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f59a42d2fb0>