Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_trunk_ModelicaTest.MultiBody.Parts.FixedRotation.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.001661/0.001661, 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.001899/0.001899, allocations: 218.3 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.561/1.561, allocations: 230.5 MB / 258.2 MB, free: 7.711 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.2478/0.2478, allocations: 46.95 MB / 361.7 MB, free: 3.848 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.FixedRotation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|fixedRotation.frame_b.r_0.1.|fixedRotation.frame_b.r_0.2.|fixedRotation.frame_b.r_0.3.|fixedRotation.frame_b.f.1.|fixedRotation.frame_b.f.2.|fixedRotation.frame_b.f.3.|fixedRotation.frame_b.t.1.|fixedRotation.frame_b.t.2.|fixedRotation.frame_b.t.3.|fixedRotation1.frame_b.r_0.1.|fixedRotation1.frame_b.r_0.2.|fixedRotation1.frame_b.r_0.3.|fixedRotation1.frame_b.f.1.|fixedRotation1.frame_b.f.2.|fixedRotation1.frame_b.f.3.|fixedRotation1.frame_b.t.1.|fixedRotation1.frame_b.t.2.|fixedRotation1.frame_b.t.3.|fixedRotation2.frame_b.r_0.1.|fixedRotation2.frame_b.r_0.2.|fixedRotation2.frame_b.r_0.3.|fixedRotation2.frame_b.f.1.|fixedRotation2.frame_b.f.2.|fixedRotation2.frame_b.f.3.|fixedRotation2.frame_b.t.1.|fixedRotation2.frame_b.t.2.|fixedRotation2.frame_b.t.3.",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.MultiBody.Parts.FixedRotation")
translateModel(ModelicaTest.MultiBody.Parts.FixedRotation,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|fixedRotation.frame_b.r_0.1.|fixedRotation.frame_b.r_0.2.|fixedRotation.frame_b.r_0.3.|fixedRotation.frame_b.f.1.|fixedRotation.frame_b.f.2.|fixedRotation.frame_b.f.3.|fixedRotation.frame_b.t.1.|fixedRotation.frame_b.t.2.|fixedRotation.frame_b.t.3.|fixedRotation1.frame_b.r_0.1.|fixedRotation1.frame_b.r_0.2.|fixedRotation1.frame_b.r_0.3.|fixedRotation1.frame_b.f.1.|fixedRotation1.frame_b.f.2.|fixedRotation1.frame_b.f.3.|fixedRotation1.frame_b.t.1.|fixedRotation1.frame_b.t.2.|fixedRotation1.frame_b.t.3.|fixedRotation2.frame_b.r_0.1.|fixedRotation2.frame_b.r_0.2.|fixedRotation2.frame_b.r_0.3.|fixedRotation2.frame_b.f.1.|fixedRotation2.frame_b.f.2.|fixedRotation2.frame_b.f.3.|fixedRotation2.frame_b.t.1.|fixedRotation2.frame_b.t.2.|fixedRotation2.frame_b.t.3.",fileNamePrefix="ModelicaTest_trunk_ModelicaTest.MultiBody.Parts.FixedRotation") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.141e-05/2.141e-05, allocations: 2.281 kB / 0.4974 GB, free: 7.039 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Parts.FixedRotation): time 0.01737/0.01739, allocations: 14.62 MB / 0.5117 GB, free: 8.352 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.009644/0.02703, allocations: 3.804 MB / 0.5154 GB, free: 4.531 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002688/0.02972, allocations: 115.6 kB / 0.5155 GB, free: 4.418 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.004318/0.03404, allocations: 2.172 MB / 0.5176 GB, free: 2.238 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.2894/0.3234, allocations: 2.608 MB / 0.5202 GB, free: 15.26 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.00151/0.325, allocations: 299.5 kB / 0.5205 GB, free: 15.26 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01114/0.3361, allocations: 6.369 MB / 0.5267 GB, free: 15.16 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004146/0.3402, allocations: 1.978 MB / 0.5286 GB, free: 14.96 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004522/0.3448, allocations: 1.915 MB / 0.5305 GB, free: 14.67 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006088/0.3508, allocations: 2.764 MB / 0.5332 GB, free: 14.34 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.000969/0.3518, allocations: 172.8 kB / 0.5334 GB, free: 14.34 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00287/0.3547, allocations: 0.6912 MB / 0.534 GB, free: 14.32 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.007908/0.3626, allocations: 7.412 MB / 0.5413 GB, free: 10.57 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.005382/0.368, allocations: 4.591 MB / 0.5457 GB, free: 7.855 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001683/0.3697, allocations: 144.4 kB / 0.5459 GB, free: 7.855 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.0006481/0.3703, allocations: 172.7 kB / 0.5461 GB, free: 7.793 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: 2817 (737)
 * Number of variables: 2817 (741)
Notification: Performance of [SIM] Bindings: time 0.02327/0.3936, allocations: 19.59 MB / 0.5652 GB, free: 10.54 MB / 398.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.002837/0.3964, allocations: 1.939 MB / 0.5671 GB, free: 8.695 MB / 398.1 MB
Notification: Performance of [SIM] Early Inline: time 25.53/25.93, allocations: 7.668 GB / 8.235 GB, free: 3.141 MB / 1.295 GB
Notification: Performance of [SIM] Simplify 1: time 20.05/45.98, allocations: 4.616 GB / 12.85 GB, free: 148.2 MB / 1.732 GB
Notification: Performance of [SIM] Alias: time 9.38/55.36, allocations: 1.781 GB / 14.63 GB, free: 0.5106 GB / 1.732 GB
Notification: Performance of [SIM] Simplify 2: time 16.33/71.69, allocations: 4.616 GB / 19.25 GB, free: 135.3 MB / 1.732 GB
Notification: Performance of [SIM] Remove Stream: time 0.7443/72.43, allocations: 273.4 MB / 19.52 GB, free: 110.1 MB / 1.732 GB
Notification: Performance of [SIM] Detect States: time 4.305/76.74, allocations: 0.7708 GB / 20.29 GB, free: 0.5836 GB / 1.732 GB
Notification: Performance of [SIM] Events: time 5.198/81.93, allocations: 2.293 GB / 22.58 GB, free: 0.8876 GB / 1.732 GB
Notification: Performance of [SIM] Partitioning: time 0.2916/82.22, allocations: 137.4 MB / 22.71 GB, free: 0.8528 GB / 1.732 GB
Notification: Performance of [SIM] Causalize: time 0.217/82.44, allocations: 102.4 MB / 22.81 GB, free: 0.8327 GB / 1.732 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.6568/83.1, allocations: 452.7 MB / 23.25 GB, free: 0.4908 GB / 1.732 GB
Notification: Performance of [INI] Simplify: time 0.2723/83.37, allocations: 200.8 MB / 23.45 GB, free: 292.2 MB / 1.732 GB
Notification: Performance of [INI] Inline: time 1.286/84.66, allocations: 0.5171 GB / 23.97 GB, free: 0.8586 GB / 1.732 GB
Notification: Performance of [INI] Partitioning: time 0.001771/84.66, allocations: 304.8 kB / 23.97 GB, free: 0.8585 GB / 1.732 GB
Notification: Performance of [INI] Cleanup: time 0.1575/84.82, allocations: 72.69 MB / 24.04 GB, free: 0.7995 GB / 1.732 GB
Notification: Performance of [INI] Causalize: time 0.2274/85.04, allocations: 106.2 MB / 24.14 GB, free: 0.7173 GB / 1.732 GB
Notification: Performance of [INI] Tearing: time 0.0003699/85.04, allocations: 0.5547 MB / 24.14 GB, free: 0.7168 GB / 1.732 GB
Notification: Performance of [SIM] Initialization: time 2.775e-06/85.04, allocations: 0 / 24.14 GB, free: 0.7168 GB / 1.732 GB
Notification: Performance of [SIM] DAE-Mode: time 0.006802/85.05, allocations: 3.676 MB / 24.15 GB, free: 0.7121 GB / 1.732 GB
Notification: Performance of [SIM] Remove Dummies: time 0.0002165/85.05, allocations: 58.2 kB / 24.15 GB, free: 0.7121 GB / 1.732 GB
Notification: Performance of [SIM] Tearing: time 0.0005389/85.05, allocations: 0.9964 MB / 24.15 GB, free: 0.7112 GB / 1.732 GB
Notification: Performance of [SIM] Categorize: time 0.0003907/85.05, allocations: 69.7 kB / 24.15 GB, free: 0.7111 GB / 1.732 GB
Notification: Performance of [SIM] Solve: time 1.372/86.42, allocations: 0.8607 GB / 25.01 GB, free: 0.8372 GB / 1.732 GB
Error: Internal error NBJacobian.SparsityColoring.PartialD2ColoringAlgC.getIndices failed because cref frameT2.y_label.r_lines[1] is neither a seed nor a partial candidate!
"
[Timeout remaining time 574]
[Calling sys.exit(0), Time elapsed: 89.39441356796306]
Failed to read output from testmodel.py, exit status != 0:
['time', 'fixedRotation.frame_b.r_0[1]', 'fixedRotation.frame_b.r_0[2]', 'fixedRotation.frame_b.r_0[3]', 'fixedRotation.frame_b.f[1]', 'fixedRotation.frame_b.f[2]', 'fixedRotation.frame_b.f[3]', 'fixedRotation.frame_b.t[1]', 'fixedRotation.frame_b.t[2]', 'fixedRotation.frame_b.t[3]', 'fixedRotation1.frame_b.r_0[1]', 'fixedRotation1.frame_b.r_0[2]', 'fixedRotation1.frame_b.r_0[3]', 'fixedRotation1.frame_b.f[1]', 'fixedRotation1.frame_b.f[2]', 'fixedRotation1.frame_b.f[3]', 'fixedRotation1.frame_b.t[1]', 'fixedRotation1.frame_b.t[2]', 'fixedRotation1.frame_b.t[3]', 'fixedRotation2.frame_b.r_0[1]', 'fixedRotation2.frame_b.r_0[2]', 'fixedRotation2.frame_b.r_0[3]', 'fixedRotation2.frame_b.f[1]', 'fixedRotation2.frame_b.f[2]', 'fixedRotation2.frame_b.f[3]', 'fixedRotation2.frame_b.t[1]', 'fixedRotation2.frame_b.t[2]', 'fixedRotation2.frame_b.t[3]']
86.47756992996437 86.487107877 86.11427153
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7fc466c46fb0>