Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.MultiBody.SphericalDoublePendulum.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.001841/0.001841, allocations: 99.64 kB / 21.25 MB, free: 428 kB / 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.00209/0.00209, allocations: 208.2 kB / 24.55 MB, free: 3.727 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.468/1.468, allocations: 230.6 MB / 258.3 MB, free: 7.785 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo): time 0.2261/0.2261, allocations: 44.94 MB / 359.7 MB, free: 6.051 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.0.0+maint.om/package.mo)
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(ModelicaTest.MultiBody.SphericalDoublePendulum,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5042,variableFilter="time|Spherical1.phi.1.|Spherical1.phi.2.|Spherical1.phi.3.|Spherical1.phi_d.1.|Spherical1.phi_d.2.|Spherical1.phi_d.3.|Spherical2.phi.1.|Spherical2.phi.2.|Spherical2.phi.3.|Spherical2.phi_d.1.|Spherical2.phi_d.2.|Spherical2.phi_d.3.|Spherical3.Q.1.|Spherical3.Q.2.|Spherical3.Q.3.|Spherical3.Q.4.|Spherical3.w_rel.1.|Spherical3.w_rel.2.|Spherical3.w_rel.3.|Spherical4.Q.1.|Spherical4.Q.2.|Spherical4.Q.3.|Spherical4.Q.4.|Spherical4.w_rel.1.|Spherical4.w_rel.2.|Spherical4.w_rel.3.|boxBody5.body.Q.1.|boxBody5.body.Q.2.|boxBody5.body.Q.3.|boxBody5.body.Q.4.|boxBody5.body.w_a.1.|boxBody5.body.w_a.2.|boxBody5.body.w_a.3.|boxBody6.body.Q.1.|boxBody6.body.Q.2.|boxBody6.body.Q.3.|boxBody6.body.Q.4.|boxBody6.body.w_a.1.|boxBody6.body.w_a.2.|boxBody6.body.w_a.3.",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.MultiBody.SphericalDoublePendulum")
translateModel(ModelicaTest.MultiBody.SphericalDoublePendulum,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5042,variableFilter="time|Spherical1.phi.1.|Spherical1.phi.2.|Spherical1.phi.3.|Spherical1.phi_d.1.|Spherical1.phi_d.2.|Spherical1.phi_d.3.|Spherical2.phi.1.|Spherical2.phi.2.|Spherical2.phi.3.|Spherical2.phi_d.1.|Spherical2.phi_d.2.|Spherical2.phi_d.3.|Spherical3.Q.1.|Spherical3.Q.2.|Spherical3.Q.3.|Spherical3.Q.4.|Spherical3.w_rel.1.|Spherical3.w_rel.2.|Spherical3.w_rel.3.|Spherical4.Q.1.|Spherical4.Q.2.|Spherical4.Q.3.|Spherical4.Q.4.|Spherical4.w_rel.1.|Spherical4.w_rel.2.|Spherical4.w_rel.3.|boxBody5.body.Q.1.|boxBody5.body.Q.2.|boxBody5.body.Q.3.|boxBody5.body.Q.4.|boxBody5.body.w_a.1.|boxBody5.body.w_a.2.|boxBody5.body.w_a.3.|boxBody6.body.Q.1.|boxBody6.body.Q.2.|boxBody6.body.Q.3.|boxBody6.body.Q.4.|boxBody6.body.w_a.1.|boxBody6.body.w_a.2.|boxBody6.body.w_a.3.",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.MultiBody.SphericalDoublePendulum") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.098e-05/2.098e-05, allocations: 6.219 kB / 0.4943 GB, free: 10.09 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.SphericalDoublePendulum): time 0.01921/0.01923, allocations: 16.24 MB / 0.5102 GB, free: 9.781 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01522/0.03445, allocations: 6.19 MB / 0.5162 GB, free: 3.57 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.006701/0.04115, allocations: 202.8 kB / 0.5164 GB, free: 3.371 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.2435/0.2847, allocations: 5.694 MB / 0.522 GB, free: 15.02 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.01045/0.2951, allocations: 3.676 MB / 0.5256 GB, free: 14.88 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.005246/0.3004, allocations: 1.805 MB / 0.5273 GB, free: 14.84 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.02388/0.3243, allocations: 17.45 MB / 0.5444 GB, free: 12.16 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.005883/0.3301, allocations: 4.442 MB / 0.5487 GB, free: 9.082 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.007039/0.3372, allocations: 3.5 MB / 0.5521 GB, free: 7.332 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.009255/0.3464, allocations: 6.656 MB / 0.5586 GB, free: 2.871 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001575/0.348, allocations: 464 kB / 0.5591 GB, free: 2.418 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.004221/0.3522, allocations: 1.428 MB / 0.5605 GB, free: 1.047 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.01332/0.3656, allocations: 11.14 MB / 0.5713 GB, free: 6.434 MB / 398.1 MB
Notification: Performance of replaceArrayConstructors: time 0.007811/0.3734, allocations: 6.376 MB / 0.5776 GB, free: 324 kB / 398.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.002646/0.376, allocations: 292 kB / 0.5778 GB, free: 32 kB / 398.1 MB
Notification: Performance of FrontEnd: time 0.0007874/0.3768, allocations: 142.9 kB / 0.578 GB, free: 15.89 MB / 414.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2557 (883)
 * Number of variables: 2557 (722)
Notification: Performance of [SIM] Bindings: time 0.04259/0.4194, allocations: 27.33 MB / 0.6047 GB, free: 4.43 MB / 430.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.006605/0.426, allocations: 3.194 MB / 0.6078 GB, free: 1.027 MB / 430.1 MB
Notification: Performance of [SIM] Early Inline: time 6.162/6.588, allocations: 1.915 GB / 2.523 GB, free: 1.938 MB / 0.7481 GB
Notification: Performance of [SIM] Simplify 1: time 3.579/10.17, allocations: 1.113 GB / 3.636 GB, free: 35.64 MB / 0.9981 GB
Notification: Performance of [SIM] Alias: time 1.879/12.05, allocations: 469.5 MB / 4.094 GB, free: 210 MB / 0.9981 GB
Notification: Performance of [SIM] Simplify 2: time 3.336/15.38, allocations: 1.113 GB / 5.207 GB, free: 100.4 MB / 0.9981 GB
Notification: Performance of [SIM] Remove Stream: time 0.2101/15.59, allocations: 69.78 MB / 5.276 GB, free: 96.18 MB / 0.9981 GB
Notification: Performance of [SIM] Detect States: time 0.9963/16.59, allocations: 200.7 MB / 5.472 GB, free: 341.2 MB / 0.9981 GB
Notification: Performance of [SIM] Events: time 1.246/17.84, allocations: 0.5674 GB / 6.039 GB, free: 224.9 MB / 0.9981 GB
Notification: Performance of [SIM] Partitioning: time 0.1055/17.94, allocations: 41.88 MB / 6.08 GB, free: 206.8 MB / 0.9981 GB
Error: Internal error NBResolveSingularities.indexReduction failed because slicing during index reduction is not yet supported.
  needed sliced dummy:		[STAT] (4) Real[4] $DER.boxBody5.body.Q
	slice: {1, 2, 3}
"
[Timeout remaining time 642]
[Calling sys.exit(0), Time elapsed: 20.776007803040557]
Failed to read output from testmodel.py, exit status != 0:
['time', 'Spherical1.phi[1]', 'Spherical1.phi[2]', 'Spherical1.phi[3]', 'Spherical1.phi_d[1]', 'Spherical1.phi_d[2]', 'Spherical1.phi_d[3]', 'Spherical2.phi[1]', 'Spherical2.phi[2]', 'Spherical2.phi[3]', 'Spherical2.phi_d[1]', 'Spherical2.phi_d[2]', 'Spherical2.phi_d[3]', 'Spherical3.Q[1]', 'Spherical3.Q[2]', 'Spherical3.Q[3]', 'Spherical3.Q[4]', 'Spherical3.w_rel[1]', 'Spherical3.w_rel[2]', 'Spherical3.w_rel[3]', 'Spherical4.Q[1]', 'Spherical4.Q[2]', 'Spherical4.Q[3]', 'Spherical4.Q[4]', 'Spherical4.w_rel[1]', 'Spherical4.w_rel[2]', 'Spherical4.w_rel[3]', 'boxBody5.body.Q[1]', 'boxBody5.body.Q[2]', 'boxBody5.body.Q[3]', 'boxBody5.body.Q[4]', 'boxBody5.body.w_a[1]', 'boxBody5.body.w_a[2]', 'boxBody5.body.w_a[3]', 'boxBody6.body.Q[1]', 'boxBody6.body.Q[2]', 'boxBody6.body.Q[3]', 'boxBody6.body.Q[4]', 'boxBody6.body.w_a[1]', 'boxBody6.body.w_a[2]', 'boxBody6.body.w_a[3]']
17.997924312017858 18.007076705 17.627711254
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f7edfc86fb0>