Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0_ModelicaTest.MultiBody.Parts.FixedRotation.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.001551/0.001551, allocations: 103.6 kB / 21.25 MB, free: 0.5664 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.001901/0.001901, allocations: 212.5 kB / 24.55 MB, free: 3.824 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.531/1.531, allocations: 230.7 MB / 258.4 MB, free: 7.773 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0+maint.om/package.mo): time 0.2636/0.2636, allocations: 46.96 MB / 361.7 MB, free: 3.984 MB / 286.1 MB
"
[Timeout remaining time 179]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.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.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_4.1.0_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_4.1.0_ModelicaTest.MultiBody.Parts.FixedRotation") [Timeout 660]
"Notification: Performance of FrontEnd - Absyn->SCode: time 2.323e-05/2.323e-05, allocations: 2.281 kB / 0.4974 GB, free: 7.215 MB / 366.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Parts.FixedRotation): time 0.0183/0.01832, allocations: 14.62 MB / 0.5117 GB, free: 8.527 MB / 382.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01123/0.02955, allocations: 3.808 MB / 0.5154 GB, free: 4.703 MB / 382.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.00312/0.03267, allocations: 111.6 kB / 0.5155 GB, free: 4.594 MB / 382.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.00473/0.0374, allocations: 2.179 MB / 0.5176 GB, free: 2.406 MB / 382.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.2712/0.3086, allocations: 2.6 MB / 0.5202 GB, free: 15.29 MB / 382.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.001598/0.3102, allocations: 295.4 kB / 0.5205 GB, free: 15.29 MB / 382.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01191/0.3221, allocations: 6.372 MB / 0.5267 GB, free: 15.2 MB / 382.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004644/0.3268, allocations: 1.977 MB / 0.5286 GB, free: 15 MB / 382.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004949/0.3317, allocations: 1.918 MB / 0.5305 GB, free: 14.7 MB / 382.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.006491/0.3382, allocations: 2.77 MB / 0.5332 GB, free: 14.38 MB / 382.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001135/0.3394, allocations: 172.1 kB / 0.5333 GB, free: 14.38 MB / 382.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.003211/0.3426, allocations: 0.6887 MB / 0.534 GB, free: 14.36 MB / 382.1 MB
Notification: Performance of combineBinaries: time 0.008574/0.3512, allocations: 7.403 MB / 0.5413 GB, free: 10.66 MB / 382.1 MB
Notification: Performance of replaceArrayConstructors: time 0.006083/0.3572, allocations: 4.598 MB / 0.5457 GB, free: 7.941 MB / 382.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.001787/0.359, allocations: 145.7 kB / 0.5459 GB, free: 7.941 MB / 382.1 MB
Notification: Performance of FrontEnd: time 0.0006457/0.3597, allocations: 169.5 kB / 0.546 GB, free: 7.879 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.02648/0.3861, allocations: 19.59 MB / 0.5652 GB, free: 10.82 MB / 398.1 MB
Notification: Performance of [SIM] FunctionAlias: time 0.003059/0.3892, allocations: 1.933 MB / 0.5671 GB, free: 8.977 MB / 398.1 MB
Notification: Performance of [SIM] Early Inline: time 24.1/24.49, allocations: 7.667 GB / 8.234 GB, free: 1.477 MB / 1.295 GB
Notification: Performance of [SIM] Simplify 1: time 18.84/43.33, allocations: 4.616 GB / 12.85 GB, free: 130.2 MB / 1.732 GB
Notification: Performance of [SIM] Alias: time 8.946/52.27, allocations: 1.781 GB / 14.63 GB, free: 0.5093 GB / 1.732 GB
Notification: Performance of [SIM] Simplify 2: time 14.94/67.21, allocations: 4.616 GB / 19.25 GB, free: 76.09 MB / 1.732 GB
Notification: Performance of [SIM] Remove Stream: time 0.7179/67.93, allocations: 273.4 MB / 19.51 GB, free: 53.05 MB / 1.732 GB
Notification: Performance of [SIM] Detect States: time 4.278/72.21, allocations: 0.7708 GB / 20.29 GB, free: 0.5617 GB / 1.732 GB
Notification: Performance of [SIM] Events: time 5.092/77.3, allocations: 2.293 GB / 22.58 GB, free: 0.8491 GB / 1.732 GB
Notification: Performance of [SIM] Partitioning: time 0.2919/77.59, allocations: 137.5 MB / 22.71 GB, free: 0.8124 GB / 1.732 GB
Notification: Performance of [SIM] Causalize: time 0.2085/77.8, allocations: 102.4 MB / 22.81 GB, free: 0.7923 GB / 1.732 GB
Notification: Performance of [SIM] After Index Reduction Inline: time 0.6196/78.42, allocations: 452.7 MB / 23.25 GB, free: 461.7 MB / 1.732 GB
Notification: Performance of [INI] Simplify: time 0.2685/78.69, allocations: 200.8 MB / 23.45 GB, free: 254.8 MB / 1.732 GB
Notification: Performance of [INI] Inline: time 1.286/79.97, allocations: 0.5171 GB / 23.97 GB, free: 0.8377 GB / 1.732 GB
Notification: Performance of [INI] Partitioning: time 0.00185/79.97, allocations: 310.5 kB / 23.97 GB, free: 0.8375 GB / 1.732 GB
Notification: Performance of [INI] Cleanup: time 0.1457/80.12, allocations: 72.68 MB / 24.04 GB, free: 0.7786 GB / 1.732 GB
Notification: Performance of [INI] Causalize: time 0.2174/80.34, allocations: 106.2 MB / 24.14 GB, free: 0.689 GB / 1.732 GB
Notification: Performance of [INI] Tearing: time 0.0002746/80.34, allocations: 0.5469 MB / 24.14 GB, free: 0.6885 GB / 1.732 GB
Notification: Performance of [SIM] Initialization: time 2.845e-06/80.34, allocations: 4 kB / 24.14 GB, free: 0.6885 GB / 1.732 GB
Notification: Performance of [SIM] DAE-Mode: time 0.005526/80.34, allocations: 3.679 MB / 24.15 GB, free: 0.6838 GB / 1.732 GB
Notification: Performance of [SIM] Remove Dummies: time 9.875e-05/80.34, allocations: 43.62 kB / 24.15 GB, free: 0.6838 GB / 1.732 GB
Notification: Performance of [SIM] Tearing: time 0.0004346/80.34, allocations: 1.003 MB / 24.15 GB, free: 0.6829 GB / 1.732 GB
Notification: Performance of [SIM] Categorize: time 0.0003439/80.34, allocations: 66 kB / 24.15 GB, free: 0.6829 GB / 1.732 GB
Notification: Performance of [SIM] Solve: time 1.344/81.69, allocations: 0.8607 GB / 25.01 GB, free: 0.8108 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 578]
[Calling sys.exit(0), Time elapsed: 84.61089030600851]
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]']
81.74132930499036 81.750246219 81.388014568
Calling exit ...
<OMPython.OMCSessionZMQ object at 0x7f3909886fb0>