Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.Spring2.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo): time 0.001532/0.001532, allocations: 109 kB / 20.54 MB, free: 1.91 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo): time 0.001635/0.001635, allocations: 191 kB / 23.72 MB, free: 5.266 MB / 14.72 MB
"
[Timeout remaining time 180]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo): time 1.301/1.301, allocations: 225.6 MB / 252.3 MB, free: 13.5 MB / 206.1 MB
"
[Timeout remaining time 179]
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.1974/0.1974, allocations: 44.92 MB / 352.4 MB, free: 12.24 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.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 4.0.0+maint.om/package.mo)
Using package Complex with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 4.0.0+maint.om/package.mo)
Using package ModelicaServices with version 4.0.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 4.0.0+maint.om/package.mo)
Running command: translateModel(ModelicaTest.MultiBody.Forces.Spring2,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.|body1.Q.1.|body1.Q.2.|body1.Q.3.|body1.Q.4.|body1.frame_a.r_0.1.|body1.frame_a.r_0.2.|body1.frame_a.r_0.3.|body1.v_0.1.|body1.v_0.2.|body1.v_0.3.|body1.w_a.1.|body1.w_a.2.|body1.w_a.3.|body2.Q.1.|body2.Q.2.|body2.Q.3.|body2.Q.4.|body2.frame_a.r_0.1.|body2.frame_a.r_0.2.|body2.frame_a.r_0.3.|body2.v_0.1.|body2.v_0.2.|body2.v_0.3.|body2.w_a.1.|body2.w_a.2.|body2.w_a.3.",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.Spring2")
translateModel(ModelicaTest.MultiBody.Forces.Spring2,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.|body1.Q.1.|body1.Q.2.|body1.Q.3.|body1.Q.4.|body1.frame_a.r_0.1.|body1.frame_a.r_0.2.|body1.frame_a.r_0.3.|body1.v_0.1.|body1.v_0.2.|body1.v_0.3.|body1.w_a.1.|body1.w_a.2.|body1.w_a.3.|body2.Q.1.|body2.Q.2.|body2.Q.3.|body2.Q.4.|body2.frame_a.r_0.1.|body2.frame_a.r_0.2.|body2.frame_a.r_0.3.|body2.v_0.1.|body2.v_0.2.|body2.v_0.3.|body2.w_a.1.|body2.w_a.2.|body2.w_a.3.",fileNamePrefix="ModelicaTest_4.0.0_ModelicaTest.MultiBody.Forces.Spring2") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.048e-05/2.048e-05, allocations: 2.281 kB / 495.9 MB, free: 1.914 MB / 350.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Forces.Spring2): time 0.01366/0.01368, allocations: 12.55 MB / 0.4966 GB, free: 5.293 MB / 366.1 MB
Notification: Performance of NFInst.instExpressions: time 0.008949/0.02263, allocations: 4.379 MB / 0.5009 GB, free: 0.8984 MB / 366.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00185/0.02447, allocations: 75.75 kB / 0.5009 GB, free: 0.8242 MB / 366.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.005154/0.02963, allocations: 2.935 MB / 0.5038 GB, free: 13.88 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.00524/0.03487, allocations: 2.144 MB / 0.5059 GB, free: 11.73 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001871/0.03674, allocations: 0.9399 MB / 0.5068 GB, free: 10.79 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.007662/0.0444, allocations: 5.966 MB / 0.5126 GB, free: 4.805 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.002341/0.04674, allocations: 1.836 MB / 0.5144 GB, free: 2.938 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002272/0.04901, allocations: 1.689 MB / 0.5161 GB, free: 1.242 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.2258/0.2749, allocations: 2.174 MB / 0.5182 GB, free: 18.67 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001475/0.2763, allocations: 204.5 kB / 0.5184 GB, free: 18.67 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003704/0.28, allocations: 1.112 MB / 0.5195 GB, free: 18.67 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.005561/0.2856, allocations: 5.355 MB / 0.5247 GB, free: 16.91 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.002955/0.2885, allocations: 3.176 MB / 0.5278 GB, free: 15.24 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001109/0.2897, allocations: 378.2 kB / 0.5282 GB, free: 15.16 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.0005664/0.2902, allocations: 108.8 kB / 0.5283 GB, free: 15.13 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: 1730 (583)
 * Number of variables: 1730 (554)
Notification: Performance of Bindings: time 0.01128/0.3015, allocations: 11.35 MB / 0.5394 GB, free: 10.03 MB / 382.1 MB
Notification: Performance of FunctionAlias: time 0.001531/0.303, allocations: 1.222 MB / 0.5406 GB, free: 9.539 MB / 382.1 MB
Notification: Performance of Early Inline: time 0.7525/1.056, allocations: 392.1 MB / 0.9235 GB, free: 12.57 MB / 0.5919 GB
Notification: Performance of Simplify 1: time 0.3567/1.412, allocations: 54.73 MB / 0.977 GB, free: 120.4 MB / 0.6075 GB
Notification: Performance of Alias: time 0.1817/1.594, allocations: 111.5 MB / 1.086 GB, free: 73.64 MB / 0.6075 GB
Notification: Performance of Simplify 2: time 0.08566/1.68, allocations: 54.52 MB / 1.139 GB, free: 37.39 MB / 0.6075 GB
Notification: Performance of Remove Stream: time 0.06839/1.748, allocations: 37.85 MB / 1.176 GB, free: 15.39 MB / 0.6231 GB
Notification: Performance of Detect States: time 0.4053/2.153, allocations: 73.43 MB / 1.248 GB, free: 126.9 MB / 0.6231 GB
Notification: Performance of Events: time 0.5797/2.733, allocations: 280.1 MB / 1.521 GB, free: 159.3 MB / 0.6387 GB
Notification: Performance of Partitioning: time 0.01506/2.748, allocations: 10.47 MB / 1.531 GB, free: 152.8 MB / 0.6387 GB
Error: Internal error NBResolveSingularities.noIndexReduction failed.
(5|5) Unmatched Variables
***************************
	[ALGB] (3) flow Real[3] world.frame_b.t
	slice: {1}
	[DER-] (4) Real[4] $DER.body1.Q
	slice: {0}
	[DER-] (4) Real[4] $DER.body.Q
	slice: {0}
	[DER-] (4) Real[4] $DER.body2.Q
	slice: {0}
	[DER-] (3) Real[3] $DER.spring2.lineForce.v_CM_0
	slice: {0}

(5|5) Unmatched Equations
***************************
	[SCAL] (1) 0.0 = (-1.0) + body.Q * body.Q ($RES_SIM_722)
	[SCAL] (1) 0.0 = (-1.0) + body1.Q * body1.Q ($RES_SIM_737)
	[SCAL] (1) 0.0 = (-1.0) + body2.Q * body2.Q ($RES_SIM_752)
	[SCAL] (1) fixedTranslation1.frame_a.R.T[1, 3] = fixedTranslation.frame_b.R.T[1, 3] ($RES_SIM_200)
	[SCAL] (1) fixedTranslation1.frame_a.R.T[1, 2] = fixedTranslation.frame_b.R.T[1, 2] ($RES_SIM_202)
"
[Timeout remaining time 657]
[Calling sys.exit(0), Time elapsed: 5.162280979566276]