Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries --ompython_omhome=/usr ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.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.00172/0.00172, allocations: 105.1 kB / 21.23 MB, free: 0.6562 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.002286/0.002286, allocations: 213.9 kB / 24.54 MB, free: 4.016 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.545/1.545, allocations: 230.3 MB / 258 MB, free: 8.234 MB / 206.1 MB
"
[Timeout remaining time 178]
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo", uses=false) [Timeout 180]
"Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/package.mo): time 0.2359/0.2359, allocations: 46.95 MB / 361.4 MB, free: 4.391 MB / 286.1 MB
"
[Timeout remaining time 180]
Using package ModelicaTest with version 4.1.0 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 4.1.0-beta.om/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.Bodies,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|bodyShape.frame_b.r_0.1.|bodyShape.frame_b.r_0.2.|bodyShape.frame_b.r_0.3.|bodyShape.frame_b.f.1.|bodyShape.frame_b.f.2.|bodyShape.frame_b.f.3.|bodyShape.frame_b.t.1.|bodyShape.frame_b.t.2.|bodyShape.frame_b.t.3.|bodyShape.frameTranslation.frame_b.r_0.1.|bodyShape.frameTranslation.frame_b.r_0.2.|bodyShape.frameTranslation.frame_b.r_0.3.|bodyShape.frameTranslation.frame_b.f.1.|bodyShape.frameTranslation.frame_b.f.2.|bodyShape.frameTranslation.frame_b.f.3.|bodyShape.frameTranslation.frame_b.t.1.|bodyShape.frameTranslation.frame_b.t.2.|bodyShape.frameTranslation.frame_b.t.3.|BodyBox1.frame_b.r_0.1.|BodyBox1.frame_b.r_0.2.|BodyBox1.frame_b.r_0.3.|BodyBox1.frame_b.f.1.|BodyBox1.frame_b.f.2.|BodyBox1.frame_b.f.3.|BodyBox1.frame_b.t.1.|BodyBox1.frame_b.t.2.|BodyBox1.frame_b.t.3.|BodyBox1.frameTranslation.frame_b.r_0.1.|BodyBox1.frameTranslation.frame_b.r_0.2.|BodyBox1.frameTranslation.frame_b.r_0.3.|BodyBox1.frameTranslation.frame_b.f.1.|BodyBox1.frameTranslation.frame_b.f.2.|BodyBox1.frameTranslation.frame_b.f.3.|BodyBox1.frameTranslation.frame_b.t.1.|BodyBox1.frameTranslation.frame_b.t.2.|BodyBox1.frameTranslation.frame_b.t.3.|bodyCylinder.frame_b.r_0.1.|bodyCylinder.frame_b.r_0.2.|bodyCylinder.frame_b.r_0.3.|bodyCylinder.frame_b.f.1.|bodyCylinder.frame_b.f.2.|bodyCylinder.frame_b.f.3.|bodyCylinder.frame_b.t.1.|bodyCylinder.frame_b.t.2.|bodyCylinder.frame_b.t.3.|bodyCylinder.frameTranslation.frame_b.r_0.1.|bodyCylinder.frameTranslation.frame_b.r_0.2.|bodyCylinder.frameTranslation.frame_b.r_0.3.|bodyCylinder.frameTranslation.frame_b.f.1.|bodyCylinder.frameTranslation.frame_b.f.2.|bodyCylinder.frameTranslation.frame_b.f.3.|bodyCylinder.frameTranslation.frame_b.t.1.|bodyCylinder.frameTranslation.frame_b.t.2.|bodyCylinder.frameTranslation.frame_b.t.3.|Fixed3.frame_b.r_0.1.|Fixed3.frame_b.r_0.2.|Fixed3.frame_b.r_0.3.|Fixed3.frame_b.f.1.|Fixed3.frame_b.f.2.|Fixed3.frame_b.f.3.|Fixed3.frame_b.t.1.|Fixed3.frame_b.t.2.|Fixed3.frame_b.t.3.|Fixed4.frame_b.r_0.1.|Fixed4.frame_b.r_0.2.|Fixed4.frame_b.r_0.3.|Fixed4.frame_b.f.1.|Fixed4.frame_b.f.2.|Fixed4.frame_b.f.3.|Fixed4.frame_b.t.1.|Fixed4.frame_b.t.2.|Fixed4.frame_b.t.3.|Fixed5.frame_b.r_0.1.|Fixed5.frame_b.r_0.2.|Fixed5.frame_b.r_0.3.|Fixed5.frame_b.f.1.|Fixed5.frame_b.f.2.|Fixed5.frame_b.f.3.|Fixed5.frame_b.t.1.|Fixed5.frame_b.t.2.|Fixed5.frame_b.t.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.|Fixed2.frame_b.r_0.1.|Fixed2.frame_b.r_0.2.|Fixed2.frame_b.r_0.3.|Fixed2.frame_b.f.1.|Fixed2.frame_b.f.2.|Fixed2.frame_b.f.3.|Fixed2.frame_b.t.1.|Fixed2.frame_b.t.2.|Fixed2.frame_b.t.3.",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies")
translateModel(ModelicaTest.MultiBody.Parts.Bodies,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5002,variableFilter="time|bodyShape.frame_b.r_0.1.|bodyShape.frame_b.r_0.2.|bodyShape.frame_b.r_0.3.|bodyShape.frame_b.f.1.|bodyShape.frame_b.f.2.|bodyShape.frame_b.f.3.|bodyShape.frame_b.t.1.|bodyShape.frame_b.t.2.|bodyShape.frame_b.t.3.|bodyShape.frameTranslation.frame_b.r_0.1.|bodyShape.frameTranslation.frame_b.r_0.2.|bodyShape.frameTranslation.frame_b.r_0.3.|bodyShape.frameTranslation.frame_b.f.1.|bodyShape.frameTranslation.frame_b.f.2.|bodyShape.frameTranslation.frame_b.f.3.|bodyShape.frameTranslation.frame_b.t.1.|bodyShape.frameTranslation.frame_b.t.2.|bodyShape.frameTranslation.frame_b.t.3.|BodyBox1.frame_b.r_0.1.|BodyBox1.frame_b.r_0.2.|BodyBox1.frame_b.r_0.3.|BodyBox1.frame_b.f.1.|BodyBox1.frame_b.f.2.|BodyBox1.frame_b.f.3.|BodyBox1.frame_b.t.1.|BodyBox1.frame_b.t.2.|BodyBox1.frame_b.t.3.|BodyBox1.frameTranslation.frame_b.r_0.1.|BodyBox1.frameTranslation.frame_b.r_0.2.|BodyBox1.frameTranslation.frame_b.r_0.3.|BodyBox1.frameTranslation.frame_b.f.1.|BodyBox1.frameTranslation.frame_b.f.2.|BodyBox1.frameTranslation.frame_b.f.3.|BodyBox1.frameTranslation.frame_b.t.1.|BodyBox1.frameTranslation.frame_b.t.2.|BodyBox1.frameTranslation.frame_b.t.3.|bodyCylinder.frame_b.r_0.1.|bodyCylinder.frame_b.r_0.2.|bodyCylinder.frame_b.r_0.3.|bodyCylinder.frame_b.f.1.|bodyCylinder.frame_b.f.2.|bodyCylinder.frame_b.f.3.|bodyCylinder.frame_b.t.1.|bodyCylinder.frame_b.t.2.|bodyCylinder.frame_b.t.3.|bodyCylinder.frameTranslation.frame_b.r_0.1.|bodyCylinder.frameTranslation.frame_b.r_0.2.|bodyCylinder.frameTranslation.frame_b.r_0.3.|bodyCylinder.frameTranslation.frame_b.f.1.|bodyCylinder.frameTranslation.frame_b.f.2.|bodyCylinder.frameTranslation.frame_b.f.3.|bodyCylinder.frameTranslation.frame_b.t.1.|bodyCylinder.frameTranslation.frame_b.t.2.|bodyCylinder.frameTranslation.frame_b.t.3.|Fixed3.frame_b.r_0.1.|Fixed3.frame_b.r_0.2.|Fixed3.frame_b.r_0.3.|Fixed3.frame_b.f.1.|Fixed3.frame_b.f.2.|Fixed3.frame_b.f.3.|Fixed3.frame_b.t.1.|Fixed3.frame_b.t.2.|Fixed3.frame_b.t.3.|Fixed4.frame_b.r_0.1.|Fixed4.frame_b.r_0.2.|Fixed4.frame_b.r_0.3.|Fixed4.frame_b.f.1.|Fixed4.frame_b.f.2.|Fixed4.frame_b.f.3.|Fixed4.frame_b.t.1.|Fixed4.frame_b.t.2.|Fixed4.frame_b.t.3.|Fixed5.frame_b.r_0.1.|Fixed5.frame_b.r_0.2.|Fixed5.frame_b.r_0.3.|Fixed5.frame_b.f.1.|Fixed5.frame_b.f.2.|Fixed5.frame_b.f.3.|Fixed5.frame_b.t.1.|Fixed5.frame_b.t.2.|Fixed5.frame_b.t.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.|Fixed2.frame_b.r_0.1.|Fixed2.frame_b.r_0.2.|Fixed2.frame_b.r_0.3.|Fixed2.frame_b.f.1.|Fixed2.frame_b.f.2.|Fixed2.frame_b.f.3.|Fixed2.frame_b.t.1.|Fixed2.frame_b.t.2.|Fixed2.frame_b.t.3.",fileNamePrefix="ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies") [Timeout 660]
"Warning: Requested package Modelica of version 4.1.0, but this package was already loaded with version trunk. OpenModelica cannot reason about compatibility between the two packages since they are not semantic versions.
Notification: Performance of FrontEnd - loaded program: time 0.002664/0.002664, allocations: 75.88 kB / 0.4972 GB, free: 7.504 MB / 366.1 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.3394/0.342, allocations: 66.04 MB / 0.5617 GB, free: 4.492 MB / 398.1 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Parts.Bodies): time 0.01772/0.3598, allocations: 14.72 MB / 0.576 GB, free: 5.703 MB / 414.1 MB
Notification: Performance of NFInst.instExpressions: time 0.01022/0.37, allocations: 4.712 MB / 0.5806 GB, free: 0.9766 MB / 414.1 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.002558/0.3725, allocations: 119.4 kB / 0.5807 GB, free: 0.8594 MB / 414.1 MB
Notification: Performance of NFTyping.typeComponents: time 0.006682/0.3792, allocations: 3.158 MB / 0.5838 GB, free: 13.69 MB / 430.1 MB
Notification: Performance of NFTyping.typeBindings: time 0.005727/0.3849, allocations: 2.081 MB / 0.5859 GB, free: 11.61 MB / 430.1 MB
Notification: Performance of NFTyping.typeClassSections: time 0.002425/0.3874, allocations: 1.014 MB / 0.5869 GB, free: 10.59 MB / 430.1 MB
Notification: Performance of NFFlatten.flatten: time 0.01092/0.3983, allocations: 6.968 MB / 0.5937 GB, free: 3.609 MB / 430.1 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.004563/0.4029, allocations: 2.576 MB / 0.5962 GB, free: 0.9648 MB / 430.1 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.004147/0.407, allocations: 1.85 MB / 0.598 GB, free: 15.11 MB / 446.1 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.005189/0.4122, allocations: 2.836 MB / 0.6008 GB, free: 12.27 MB / 446.1 MB
Notification: Performance of NFPackage.collectConstants: time 0.001059/0.4132, allocations: 356 kB / 0.6011 GB, free: 11.92 MB / 446.1 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002043/0.4153, allocations: 0.9092 MB / 0.602 GB, free: 11.01 MB / 446.1 MB
Notification: Performance of NFScalarize.scalarize: time 0.002602/0.4179, allocations: 2.342 MB / 0.6043 GB, free: 8.66 MB / 446.1 MB
Notification: Performance of NFVerifyModel.verify: time 0.003487/0.4214, allocations: 2.273 MB / 0.6065 GB, free: 6.375 MB / 446.1 MB
Notification: Performance of NFConvertDAE.convert: time 0.008854/0.4302, allocations: 6.713 MB / 0.613 GB, free: 15.64 MB / 462.1 MB
Notification: Performance of FrontEnd - DAE generated: time 5.941e-06/0.4302, allocations: 3.938 kB / 0.613 GB, free: 15.63 MB / 462.1 MB
Notification: Performance of FrontEnd: time 1.874e-06/0.4302, allocations: 4 kB / 0.613 GB, free: 15.63 MB / 462.1 MB
Notification: Performance of Transformations before backend: time 0.0001729/0.4304, allocations: 0 / 0.613 GB, free: 15.63 MB / 462.1 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1021
 * Number of variables: 1021
Notification: Performance of Generate backend data structure: time 0.01122/0.4416, allocations: 5.23 MB / 0.6182 GB, free: 10.34 MB / 462.1 MB
Notification: Performance of prepare preOptimizeDAE: time 3.917e-05/0.4417, allocations: 16.03 kB / 0.6182 GB, free: 10.32 MB / 462.1 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01602/0.4577, allocations: 1.855 MB / 0.62 GB, free: 8.461 MB / 462.1 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01018/0.4679, allocations: 4.036 MB / 0.6239 GB, free: 4.344 MB / 462.1 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002023/0.4681, allocations: 197.6 kB / 0.6241 GB, free: 4.148 MB / 462.1 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.0007594/0.4688, allocations: 299.9 kB / 0.6244 GB, free: 3.855 MB / 462.1 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.01261/0.4815, allocations: 7.035 MB / 0.6313 GB, free: 12.26 MB / 478.1 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001328/0.4816, allocations: 63.53 kB / 0.6313 GB, free: 12.2 MB / 478.1 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.00031/0.4819, allocations: 127.9 kB / 0.6315 GB, free: 12.07 MB / 478.1 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001619/0.4835, allocations: 1.002 MB / 0.6324 GB, free: 11.07 MB / 478.1 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.01131/0.4948, allocations: 5.186 MB / 0.6375 GB, free: 5.879 MB / 478.1 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.04105/0.5359, allocations: 27.42 MB / 0.6643 GB, free: 9.73 MB / 0.4981 GB
Notification: Performance of preOpt comSubExp (simulation): time 0.002734/0.5386, allocations: 0.723 MB / 0.665 GB, free: 8.961 MB / 0.4981 GB
Notification: Performance of preOpt resolveLoops (simulation): time 0.0004112/0.539, allocations: 216.3 kB / 0.6652 GB, free: 8.734 MB / 0.4981 GB
Notification: Performance of preOpt evalFunc (simulation): time 4.298e-05/0.5391, allocations: 8.297 kB / 0.6652 GB, free: 8.727 MB / 0.4981 GB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.549e-05/0.5391, allocations: 46.5 kB / 0.6652 GB, free: 8.672 MB / 0.4981 GB
Notification: Performance of pre-optimization done (n=37): time 3.657e-06/0.5391, allocations: 0 / 0.6652 GB, free: 8.672 MB / 0.4981 GB
Notification: Performance of matching and sorting (n=37): time 0.007554/0.5467, allocations: 1.958 MB / 0.6671 GB, free: 6.703 MB / 0.4981 GB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001554/0.5468, allocations: 243.3 kB / 0.6674 GB, free: 6.41 MB / 0.4981 GB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.008369/0.5552, allocations: 4.721 MB / 0.672 GB, free: 1.684 MB / 0.4981 GB
Notification: Performance of collectPreVariables (initialization): time 9.59e-05/0.5553, allocations: 37.64 kB / 0.672 GB, free: 1.641 MB / 0.4981 GB
Notification: Performance of collectInitialEqns (initialization): time 0.002612/0.5579, allocations: 2.786 MB / 0.6747 GB, free: 14.83 MB / 0.5137 GB
Notification: Performance of collectInitialBindings (initialization): time 0.0002784/0.5582, allocations: 210.8 kB / 0.6749 GB, free: 14.62 MB / 0.5137 GB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001039/0.5592, allocations: 0.8057 MB / 0.6757 GB, free: 13.81 MB / 0.5137 GB
Notification: Performance of setup shared object (initialization): time 0.0001349/0.5594, allocations: 309.5 kB / 0.676 GB, free: 13.5 MB / 0.5137 GB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.001502/0.5609, allocations: 0.9094 MB / 0.6769 GB, free: 12.59 MB / 0.5137 GB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.003753/0.5646, allocations: 3.635 MB / 0.6805 GB, free: 7.598 MB / 0.5137 GB
Notification: Performance of analyzeInitialSystem (initialization): time 0.005951/0.5706, allocations: 4.798 MB / 0.6851 GB, free: 1.438 MB / 0.5137 GB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 6.327e-05/0.5706, allocations: 35.69 kB / 0.6852 GB, free: 1.406 MB / 0.5137 GB
Notification: Performance of matching and sorting (n=499) (initialization): time 0.008341/0.579, allocations: 4.416 MB / 0.6895 GB, free: 12.98 MB / 0.5294 GB
Notification: Performance of prepare postOptimizeDAE: time 6.789e-05/0.579, allocations: 48 kB / 0.6895 GB, free: 12.94 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000104/0.5791, allocations: 96 kB / 0.6896 GB, free: 12.84 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (initialization): time 0.0001376/0.5793, allocations: 131.9 kB / 0.6898 GB, free: 12.71 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.002565/0.5818, allocations: 0.9399 MB / 0.6907 GB, free: 11.77 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.0001595/0.582, allocations: 183.3 kB / 0.6908 GB, free: 11.59 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.003578/0.5856, allocations: 0.5895 MB / 0.6914 GB, free: 11 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.0003141/0.5859, allocations: 244 kB / 0.6917 GB, free: 10.76 MB / 0.5294 GB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 442
 * Number of states: 0 ()
 * Number of discrete variables: 54 (world.groundColor[3],world.groundColor[2],world.groundColor[1],world.gravitySphereColor[3],world.gravitySphereColor[2],world.gravitySphereColor[1],world.gravityArrowColor[3],world.gravityArrowColor[2],world.gravityArrowColor[1],world.axisColor_x[3],world.axisColor_x[2],world.axisColor_x[1],Fixed2.color[3],Fixed2.color[2],Fixed2.color[1],Fixed1.color[3],Fixed1.color[2],Fixed1.color[1],body1.sphereColor[3],body1.sphereColor[2],body1.sphereColor[1],Fixed5.color[3],Fixed5.color[2],Fixed5.color[1],Fixed4.color[3],Fixed4.color[2],Fixed4.color[1],Fixed3.color[3],Fixed3.color[2],Fixed3.color[1],bodyCylinder.color[3],bodyCylinder.color[2],bodyCylinder.color[1],bodyCylinder.body.sphereColor[3],bodyCylinder.body.sphereColor[2],bodyCylinder.body.sphereColor[1],BodyBox1.color[3],BodyBox1.color[2],BodyBox1.color[1],BodyBox1.body.sphereColor[3],BodyBox1.body.sphereColor[2],BodyBox1.body.sphereColor[1],bodyShape.color[3],bodyShape.color[2],bodyShape.color[1],bodyShape.body.sphereColor[3],bodyShape.body.sphereColor[2],bodyShape.body.sphereColor[1],bodyShape.frameTranslation.color[3],bodyShape.frameTranslation.color[2],bodyShape.frameTranslation.color[1],body2.sphereColor[3],body2.sphereColor[2],body2.sphereColor[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (499):
 * Single equations (assignments): 499
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.002684/0.5886, allocations: 1.641 MB / 0.6933 GB, free: 9.109 MB / 0.5294 GB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008716/0.5895, allocations: 381.5 kB / 0.6936 GB, free: 8.734 MB / 0.5294 GB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.0007322/0.5902, allocations: 380.2 kB / 0.694 GB, free: 8.363 MB / 0.5294 GB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 7.414e-06/0.5902, allocations: 4 kB / 0.694 GB, free: 8.359 MB / 0.5294 GB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.312e-05/0.5902, allocations: 4 kB / 0.694 GB, free: 8.355 MB / 0.5294 GB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.444e-06/0.5902, allocations: 7.984 kB / 0.694 GB, free: 8.348 MB / 0.5294 GB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.008214/0.5984, allocations: 4.715 MB / 0.6986 GB, free: 3.375 MB / 0.5294 GB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.813e-05/0.5984, allocations: 16 kB / 0.6986 GB, free: 3.359 MB / 0.5294 GB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.0003293/0.5988, allocations: 115.8 kB / 0.6987 GB, free: 3.246 MB / 0.5294 GB
Notification: Performance of postOpt tearingSystem (simulation): time 1.867e-05/0.5988, allocations: 20.03 kB / 0.6988 GB, free: 3.227 MB / 0.5294 GB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 4.38e-05/0.5988, allocations: 28 kB / 0.6988 GB, free: 3.199 MB / 0.5294 GB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 2.246e-05/0.5989, allocations: 23.88 kB / 0.6988 GB, free: 3.176 MB / 0.5294 GB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 1.945e-05/0.5989, allocations: 19.94 kB / 0.6988 GB, free: 3.156 MB / 0.5294 GB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.002072/0.601, allocations: 1.262 MB / 0.7001 GB, free: 1.672 MB / 0.5294 GB
Notification: Performance of postOpt removeConstants (simulation): time 0.001144/0.6021, allocations: 425.2 kB / 0.7005 GB, free: 1.254 MB / 0.5294 GB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0003636/0.6025, allocations: 31.98 kB / 0.7005 GB, free: 1.223 MB / 0.5294 GB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.0009313/0.6034, allocations: 35.98 kB / 0.7005 GB, free: 1.188 MB / 0.5294 GB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.000108/0.6035, allocations: 87.55 kB / 0.7006 GB, free: 1.102 MB / 0.5294 GB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 3.936e-05/0.6035, allocations: 36 kB / 0.7006 GB, free: 1.066 MB / 0.5294 GB
Notification: Performance of sorting global known variables: time 0.006018/0.6096, allocations: 3.102 MB / 0.7037 GB, free: 13.97 MB / 0.545 GB
Notification: Performance of sort global known variables: time 2.6e-07/0.6096, allocations: 0 / 0.7037 GB, free: 13.97 MB / 0.545 GB
Notification: Performance of remove unused functions: time 0.004827/0.6144, allocations: 0.8696 MB / 0.7045 GB, free: 13.1 MB / 0.545 GB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 61
 * Number of states: 0 ()
 * Number of discrete variables: 0 ()
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for simulation (61):
 * Single equations (assignments): 61
 * Array equations: 0
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (not torn): 0
 * Torn equation systems: 0
 * Mixed (continuous/discrete) equation systems: 0
Notification: Performance of Backend phase and start with SimCode phase: time 0.0003699/0.6148, allocations: 147 kB / 0.7047 GB, free: 12.94 MB / 0.545 GB
Notification: Performance of simCode: created initialization part: time 0.004159/0.6189, allocations: 2.051 MB / 0.7067 GB, free: 10.91 MB / 0.545 GB
Notification: Performance of simCode: created event and clocks part: time 7.554e-06/0.6189, allocations: 0.8125 kB / 0.7067 GB, free: 10.91 MB / 0.545 GB
Notification: Performance of simCode: created simulation system equations: time 0.0003568/0.6193, allocations: 259 kB / 0.7069 GB, free: 10.66 MB / 0.545 GB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.00342/0.6227, allocations: 0.6371 MB / 0.7075 GB, free: 10.03 MB / 0.545 GB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.01192/0.6346, allocations: 7.386 MB / 0.7147 GB, free: 2.426 MB / 0.545 GB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.003169/0.6378, allocations: 2.842 MB / 0.7175 GB, free: 15.56 MB / 0.5606 GB
Notification: Performance of simCode: alias equations: time 0.002859/0.6406, allocations: 1.153 MB / 0.7186 GB, free: 14.4 MB / 0.5606 GB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.0004836/0.6411, allocations: 203.4 kB / 0.7188 GB, free: 14.2 MB / 0.5606 GB
Notification: Performance of SimCode: time 1.082e-06/0.6411, allocations: 0 / 0.7188 GB, free: 14.2 MB / 0.5606 GB
Notification: Performance of Templates: time 0.354/0.9951, allocations: 28.94 MB / 0.7471 GB, free: 148.7 MB / 0.5606 GB
"
[Timeout remaining time 659]
make -j1 -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.makefile [Timeout 660]
(rm -f ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.pipe ; mkfifo ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.pipe ; head -c 1048576 < ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.pipe >> ../files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.sim & ./ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies  -abortSlowSimulation -alarm=480  -emit_protected -lv LOG_STATS > ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.pipe 2>&1) [Timeout 480]
diffSimulationResults("ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies_res.mat","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/Reference-modelica.org/ReferenceResults/MAP-LIB_ReferenceResults/v4.1.0/ModelicaTest/MultiBody/Parts/Bodies/Bodies.csv","/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelicaLibraryTesting/files/ModelicaTest_4.1.0-beta.om_ModelicaTest.MultiBody.Parts.Bodies.diff",relTol=0.003,relTolDiffMinMax=0.003,rangeDelta=0.001) [Timeout 660]
""
[Timeout remaining time 660]
Reference file matches
[Calling sys.exit(0), Time elapsed: 7.199606294743717]