Running: ./testmodel.py --libraries=/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/./OMCompiler/build/lib/omlibrary/ --ompython_omhome=/usr Modelica_3.2.2_cpp_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.conf.json
Using package ModelicaServices with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/ModelicaServices 3.2.2/package.mo)
Using package Complex with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Complex 3.2.2.mo)
Using package Modelica with version 3.2.2 (/var/lib/jenkins/ws/OpenModelicaLibraryTestingWork/OpenModelica/OMCompiler/build/lib/omlibrary/Modelica 3.2.2/package.mo)
Running command: translateModel(Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|bodyOfConstraint.v_0.1.|bodyOfConstraint.v_0.2.|bodyOfConstraint.v_0.3.|constraint.frame_b.r_0.1.|constraint.frame_b.r_0.2.|constraint.frame_b.r_0.3.|jointPrismatic_x.s|jointPrismatic_x.v|jointPrismatic_y.s|jointPrismatic_y.v",fileNamePrefix="Modelica_3.2.2_cpp_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint")
Notification: Performance of loadModel(Modelica): time 1.906/1.906, allocations: 194.9 MB / 212.3 MB, free: 3.004 MB / 170.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0003596/0.0003596, allocations: 8 kB / 264.5 MB, free: 13.63 MB / 218.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.1018/0.1022, allocations: 44.5 MB / 309 MB, free: 1.062 MB / 250.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.4955/0.5978, allocations: 106.3 MB / 415.3 MB, free: 10.88 MB / 314.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.0003397/0.5982, allocations: 93.42 kB / 415.4 MB, free: 10.87 MB / 314.7 MB
Notification: Performance of FrontEnd - DAE generated: time 1.108/1.706, allocations: 136.9 MB / 0.5393 GB, free: 68.2 MB / 410.7 MB
Notification: Performance of FrontEnd: time 3.807e-06/1.706, allocations: 1.781 kB / 0.5393 GB, free: 68.2 MB / 410.7 MB
Notification: Performance of Transformations before backend: time 0.0005406/1.707, allocations: 155.8 kB / 0.5395 GB, free: 68.2 MB / 410.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 2549
 * Number of variables: 2549
Notification: Performance of Generate backend data structure: time 0.04097/1.748, allocations: 7.686 MB / 0.547 GB, free: 65.32 MB / 410.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.588e-05/1.748, allocations: 7.188 kB / 0.547 GB, free: 65.32 MB / 410.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02307/1.771, allocations: 2.879 MB / 0.5498 GB, free: 64.83 MB / 410.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.02984/1.801, allocations: 7.684 MB / 0.5573 GB, free: 63.99 MB / 410.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0008117/1.802, allocations: 0.5661 MB / 0.5579 GB, free: 63.98 MB / 410.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.004735/1.807, allocations: 0.7516 MB / 0.5586 GB, free: 63.97 MB / 410.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06394/1.871, allocations: 18.5 MB / 0.5767 GB, free: 60.45 MB / 410.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0006039/1.871, allocations: 77.69 kB / 0.5768 GB, free: 60.45 MB / 410.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.004295/1.876, allocations: 354.2 kB / 0.5771 GB, free: 60.45 MB / 410.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.004352/1.88, allocations: 1.715 MB / 0.5788 GB, free: 60.42 MB / 410.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05215/1.932, allocations: 15.18 MB / 0.5936 GB, free: 58.98 MB / 410.7 MB
Warning: The model contains alias variables with redundant start and/or conflicting nominal values. It is recommended to resolve the conflicts, because otherwise the system could be hard to solve. To print the conflicting alias sets and the chosen candidates please use -d=aliasConflicts.
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.192/2.124, allocations: 75.77 MB / 0.6676 GB, free: 14.75 MB / 426.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.0572/2.182, allocations: 7.657 MB / 0.6751 GB, free: 8.527 MB / 426.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.3508/2.532, allocations: 14.2 MB / 0.6889 GB, free: 77.54 MB / 426.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 6.592e-05/2.533, allocations: 65.66 kB / 0.689 GB, free: 77.5 MB / 426.7 MB
Notification: Performance of pre-optimization done (n=251): time 7.183e-06/2.533, allocations: 2.531 kB / 0.689 GB, free: 77.5 MB / 426.7 MB
Notification: Performance of matching and sorting (n=297): time 0.1715/2.704, allocations: 32.77 MB / 0.721 GB, free: 72.16 MB / 426.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 0.0001012/2.704, allocations: 163.9 kB / 0.7211 GB, free: 72 MB / 426.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.01911/2.723, allocations: 5.831 MB / 0.7268 GB, free: 71.49 MB / 426.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.001043/2.725, allocations: 68.86 kB / 0.7269 GB, free: 71.46 MB / 426.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.005929/2.73, allocations: 4.837 MB / 0.7316 GB, free: 68.98 MB / 426.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.002617/2.733, allocations: 1.139 MB / 0.7327 GB, free: 68.32 MB / 426.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001481/2.735, allocations: 177.5 kB / 0.7329 GB, free: 68.32 MB / 426.7 MB
Notification: Performance of setup shared object (initialization): time 0.0007214/2.735, allocations: 0.6843 MB / 0.7336 GB, free: 67.99 MB / 426.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.009257/2.745, allocations: 3.362 MB / 0.7369 GB, free: 67.96 MB / 426.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01373/2.758, allocations: 8.64 MB / 0.7453 GB, free: 61.02 MB / 426.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01302/2.772, allocations: 5.252 MB / 0.7504 GB, free: 59.15 MB / 426.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0003031/2.772, allocations: 51.56 kB / 0.7505 GB, free: 59.15 MB / 426.7 MB
Warning: The linear system: 
1 : bodyOfConstraint.v_0[1] = 0.2148655148851041 * freeMotionScalarInit.v_rel_a_1 + (-0.5318108111446446) * freeMotionScalarInit.v_rel_a_2 + 0.8191520442889918 * freeMotionScalarInit.v_rel_a_3
2 : 0.0 = 0.8191520442889918 * bodyOfConstraint.v_0[1] + (-0.09960050292505122) * bodyOfConstraint.v_0[2] + 0.5648625214636235 * bodyOfConstraint.v_0[3]
3 : bodyOfConstraint.v_0[2] = 0.9663834860128886 * freeMotionScalarInit.v_rel_a_1 + 0.2370288965055821 * freeMotionScalarInit.v_rel_a_2 + (-0.09960050292505122) * freeMotionScalarInit.v_rel_a_3
4 : bodyOfConstraint.v_0[3] = (-0.1411940808771254) * freeMotionScalarInit.v_rel_a_1 + 0.8130157214783864 * freeMotionScalarInit.v_rel_a_2 + 0.5648625214636235 * freeMotionScalarInit.v_rel_a_3
[
  0.0 , -0.2148655148851041 , 0.0 , 1.0 ;
  -0.5648625214636235 , 0.0 , 0.09960050292505122 , -0.8191520442889918 ;
  0.0 , -0.9663834860128886 , 1.0 , 0.0 ;
  1.0 , 0.1411940808771254 , 0.0 , 0.0
]
  *
[
  bodyOfConstraint.v_0[3] ;
  freeMotionScalarInit.v_rel_a_1 ;
  bodyOfConstraint.v_0[2] ;
  bodyOfConstraint.v_0[1]
]
  =
[
  (-0.5318108111446446) * freeMotionScalarInit.v_rel_a_2 + 0.8191520442889918 * freeMotionScalarInit.v_rel_a_3 ;
  -0.0 ;
  0.2370288965055821 * freeMotionScalarInit.v_rel_a_2 + (-0.09960050292505122) * freeMotionScalarInit.v_rel_a_3 ;
  0.8130157214783864 * freeMotionScalarInit.v_rel_a_2 + 0.5648625214636235 * freeMotionScalarInit.v_rel_a_3
]
 might be structurally or numerically singular for variable bodyOfConstraint.v_0[1] since U(4,4) = 0.0. It might be hard to solve. Compilation continues anyway.
Notification: Performance of matching and sorting (n=1155) (initialization): time 0.04606/2.818, allocations: 13.79 MB / 0.7639 GB, free: 54.45 MB / 426.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001563/2.818, allocations: 94.52 kB / 0.764 GB, free: 54.44 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0003152/2.819, allocations: 183.9 kB / 0.7642 GB, free: 54.44 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.01262/2.831, allocations: 2.264 MB / 0.7664 GB, free: 53.99 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.01408/2.845, allocations: 2.088 MB / 0.7685 GB, free: 53.75 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.03662/2.882, allocations: 20.81 MB / 0.7888 GB, free: 39.91 MB / 426.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.01125/2.893, allocations: 0.5065 MB / 0.7893 GB, free: 39.75 MB / 426.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.002449/2.896, allocations: 0.5138 MB / 0.7898 GB, free: 39.68 MB / 426.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 849
 * Number of states: 0 ()
 * Number of discrete variables: 60 (freeMotionScalarInit.arrowColor[3],freeMotionScalarInit.arrowColor[2],freeMotionScalarInit.arrowColor[1],fixedTranslation.color[3],fixedTranslation.color[2],fixedTranslation.color[1],fixedRotation.color[3],fixedRotation.color[2],fixedRotation.color[1],world.gravityArrowColor[3],world.gravityArrowColor[2],world.gravityArrowColor[1],world.axisColor_x[3],world.axisColor_x[2],world.axisColor_x[1],world.gravitySphereColor[3],world.gravitySphereColor[2],world.gravitySphereColor[1],springOfConstraint.color[3],springOfConstraint.color[2],springOfConstraint.color[1],springOfConstraint.massColor[3],springOfConstraint.massColor[2],springOfConstraint.massColor[1],springOfJoint.color[3],springOfJoint.color[2],springOfJoint.color[1],springOfJoint.massColor[3],springOfJoint.massColor[2],springOfJoint.massColor[1],bodyOfConstraint.color[3],bodyOfConstraint.color[2],bodyOfConstraint.color[1],bodyOfConstraint.body.sphereColor[3],bodyOfConstraint.body.sphereColor[2],bodyOfConstraint.body.sphereColor[1],bodyOfConstraint.frameTranslation.color[3],bodyOfConstraint.frameTranslation.color[2],bodyOfConstraint.frameTranslation.color[1],bodyOfJoint.color[3],bodyOfJoint.color[2],bodyOfJoint.color[1],bodyOfJoint.body.sphereColor[3],bodyOfJoint.body.sphereColor[2],bodyOfJoint.body.sphereColor[1],bodyOfJoint.frameTranslation.color[3],bodyOfJoint.frameTranslation.color[2],bodyOfJoint.frameTranslation.color[1],sensorConstraintRelative.arrowColor[3],sensorConstraintRelative.arrowColor[2],sensorConstraintRelative.arrowColor[1],constraint.sphereColor[3],constraint.sphereColor[2],constraint.sphereColor[1],jointPrismatic_y.boxColor[3],jointPrismatic_y.boxColor[2],jointPrismatic_y.boxColor[1],jointPrismatic_x.boxColor[3],jointPrismatic_x.boxColor[2],jointPrismatic_x.boxColor[1])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (1072):
 * Single equations (assignments): 1061
 * Array equations: 4
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 7
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 6 {(4,75.0%) 5,(1,100.0%) 3,(1,100.0%) 3,(2,100.0%) 6,(4,100.0%) 9,(4,100.0%) 9}
 * Non-linear torn systems: 1 {4 9}
Notification: Performance of prepare postOptimizeDAE: time 0.01053/2.906, allocations: 3.372 MB / 0.7931 GB, free: 36.88 MB / 426.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001628/2.908, allocations: 0.5262 MB / 0.7936 GB, free: 36.34 MB / 426.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.02384/2.932, allocations: 7.156 MB / 0.8006 GB, free: 30.43 MB / 426.7 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 0.0001002/2.932, allocations: 42.42 kB / 0.8006 GB, free: 30.4 MB / 426.7 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 4.725e-05/2.932, allocations: 8 kB / 0.8006 GB, free: 30.39 MB / 426.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 7.593e-05/2.932, allocations: 18.11 kB / 0.8006 GB, free: 30.39 MB / 426.7 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.04646/2.979, allocations: 15.39 MB / 0.8157 GB, free: 17.78 MB / 426.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 3.94e-05/2.979, allocations: 1.312 kB / 0.8157 GB, free: 17.78 MB / 426.7 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.00584/2.985, allocations: 0.5214 MB / 0.8162 GB, free: 17.39 MB / 426.7 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.0119/2.997, allocations: 2.072 MB / 0.8182 GB, free: 15.93 MB / 426.7 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0007972/2.997, allocations: 59.52 kB / 0.8182 GB, free: 15.88 MB / 426.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.3929/3.39, allocations: 23.19 MB / 0.8409 GB, free: 78.29 MB / 442.7 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 5.571e-06/3.39, allocations: 2.625 kB / 0.8409 GB, free: 78.29 MB / 442.7 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.05057/3.441, allocations: 10.97 MB / 0.8516 GB, free: 77.34 MB / 442.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.006529/3.448, allocations: 1.008 MB / 0.8526 GB, free: 77.25 MB / 442.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.003669/3.451, allocations: 51.42 kB / 0.8526 GB, free: 77.25 MB / 442.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.009271/3.461, allocations: 190.4 kB / 0.8528 GB, free: 77.25 MB / 442.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.001966/3.463, allocations: 201.6 kB / 0.853 GB, free: 77.25 MB / 442.7 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.001127/3.464, allocations: 79.5 kB / 0.8531 GB, free: 77.25 MB / 442.7 MB
Notification: Performance of sorting global known variables: time 0.02821/3.492, allocations: 3.613 MB / 0.8566 GB, free: 77.03 MB / 442.7 MB
Notification: Performance of sort global known variables: time 3.356e-06/3.492, allocations: 0 / 0.8566 GB, free: 77.03 MB / 442.7 MB
Notification: Performance of remove unused functions: time 0.0225/3.515, allocations: 1.742 MB / 0.8583 GB, free: 77.03 MB / 442.7 MB
Notification: Model statistics after passing the back-end for simulation:
 * Number of independent subsystems: 4
 * Number of states: 8 (bodyOfJoint.v_0[2],bodyOfJoint.v_0[3],bodyOfJoint.body.frame_a.r_0[2],bodyOfJoint.body.frame_a.r_0[3],bodyOfConstraint.v_0[2],bodyOfConstraint.v_0[3],bodyOfConstraint.body.frame_a.r_0[2],bodyOfConstraint.body.frame_a.r_0[3])
 * 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 (214):
 * Single equations (assignments): 201
 * Array equations: 4
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 9
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 8 {(2,100.0%) 6,(1,100.0%) 3,(4,75.0%) 5,(2,100.0%) 1,(4,100.0%) 9,(4,100.0%) 9,(1,100.0%) 3,(2,100.0%) 1}
 * Non-linear torn systems: 1 {4 9}
Notification: Performance of Backend phase and start with SimCode phase: time 0.00225/3.517, allocations: 258.8 kB / 0.8586 GB, free: 76.95 MB / 442.7 MB
Notification: Performance of simCode: created initialization part: time 0.03458/3.552, allocations: 9.249 MB / 0.8676 GB, free: 76.08 MB / 442.7 MB
Notification: Performance of simCode: created event and clocks part: time 1.156e-05/3.552, allocations: 5.984 kB / 0.8676 GB, free: 76.08 MB / 442.7 MB
Notification: Performance of simCode: created simulation system equations: time 0.01685/3.569, allocations: 4.185 MB / 0.8717 GB, free: 75.02 MB / 442.7 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.01015/3.579, allocations: 0.7435 MB / 0.8724 GB, free: 74.99 MB / 442.7 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.07655/3.655, allocations: 19.77 MB / 0.8917 GB, free: 67.93 MB / 442.7 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.01975/3.675, allocations: 5.28 MB / 0.8969 GB, free: 67.03 MB / 442.7 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.004088/3.679, allocations: 415.5 kB / 0.8973 GB, free: 67.02 MB / 442.7 MB
Notification: Performance of SimCode: time 2.484e-06/3.679, allocations: 0 / 0.8973 GB, free: 67.02 MB / 442.7 MB
Notification: Performance of Templates: time 1.341/5.021, allocations: 325.1 MB / 1.215 GB, free: 108.3 MB / 474.7 MB