Running: ./testmodel.py --libraries=/home/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.conf.json
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo", uses=false)
loadFile("/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo", uses=false)
Using package ModelicaServices with version 3.2.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: translateModel(Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint")
translateModel(Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint,tolerance=1e-06,outputFormat="empty",numberOfIntervals=5000,variableFilter="",fileNamePrefix="Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint")
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.001464/0.001464, allocations: 170.3 kB / 12.72 MB, free: 2.594 MB / 13.93 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 1.327/1.327, allocations: 170.6 MB / 183.8 MB, free: 11.48 MB / 154.7 MB
Notification: Performance of loadFile(/home/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.001593/0.001593, allocations: 103.5 kB / 223.2 MB, free: 4.109 MB / 186.7 MB
Notification: Performance of FrontEnd - loaded program: time 2.302e-05/2.305e-05, allocations: 4 kB / 268.9 MB, free: 20.93 MB / 202.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.0624/0.06244, allocations: 38.77 MB / 307.6 MB, free: 14.14 MB / 234.7 MB
Notification: Performance of FrontEnd - scodeFlatten: time 0.268/0.3305, allocations: 100.5 MB / 408.2 MB, free: 8.168 MB / 298.7 MB
Notification: Performance of FrontEnd - mkProgramGraph: time 0.000209/0.3307, allocations: 85.95 kB / 408.2 MB, free: 8.125 MB / 298.7 MB
Notification: Performance of FrontEnd - DAE generated: time 0.4534/0.7841, allocations: 136.1 MB / 0.5316 GB, free: 57.21 MB / 346.7 MB
Notification: Performance of FrontEnd: time 1.383e-06/0.7841, allocations: 0 / 0.5316 GB, free: 57.21 MB / 346.7 MB
Notification: Performance of Transformations before backend: time 0.0002317/0.7844, allocations: 151.9 kB / 0.5317 GB, free: 57.06 MB / 346.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.01879/0.8032, allocations: 7.254 MB / 0.5388 GB, free: 49.73 MB / 346.7 MB
Notification: Performance of prepare preOptimizeDAE: time 4.287e-05/0.8032, allocations: 8.031 kB / 0.5388 GB, free: 49.73 MB / 346.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.01264/0.8159, allocations: 2.884 MB / 0.5416 GB, free: 46.83 MB / 346.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01556/0.8315, allocations: 7.645 MB / 0.5491 GB, free: 39.1 MB / 346.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0003054/0.8318, allocations: 0.5578 MB / 0.5496 GB, free: 38.54 MB / 346.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001989/0.8338, allocations: 0.7497 MB / 0.5504 GB, free: 37.79 MB / 346.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.03298/0.8668, allocations: 18.17 MB / 0.5681 GB, free: 18.34 MB / 346.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0002747/0.8671, allocations: 83.19 kB / 0.5682 GB, free: 18.25 MB / 346.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001239/0.8684, allocations: 355.8 kB / 0.5685 GB, free: 17.91 MB / 346.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.001836/0.8702, allocations: 1.598 MB / 0.5701 GB, free: 16.3 MB / 346.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.02796/0.8982, allocations: 14.85 MB / 0.5846 GB, free: 1.438 MB / 346.7 MB
Warning: The model contains alias variables with conflicting start and/or 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.4157/1.314, allocations: 75.42 MB / 0.6582 GB, free: 21.63 MB / 362.8 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02079/1.335, allocations: 7.577 MB / 0.6656 GB, free: 19.43 MB / 362.8 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.004139/1.339, allocations: 3.247 MB / 0.6688 GB, free: 18.02 MB / 362.8 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.02003/1.359, allocations: 14.05 MB / 0.6825 GB, free: 10.71 MB / 362.8 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.09e-05/1.359, allocations: 63.12 kB / 0.6826 GB, free: 10.66 MB / 362.8 MB
Notification: Performance of pre-optimization done (n=251): time 6.372e-06/1.359, allocations: 0 / 0.6826 GB, free: 10.66 MB / 362.8 MB
Notification: Performance of matching and sorting (n=297): time 0.0794/1.439, allocations: 29.78 MB / 0.7117 GB, free: 9.012 MB / 378.8 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 8.71e-05/1.439, allocations: 163.8 kB / 0.7118 GB, free: 8.828 MB / 378.8 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.009049/1.448, allocations: 5.142 MB / 0.7169 GB, free: 4.242 MB / 378.8 MB
Notification: Performance of collectPreVariables (initialization): time 0.0009152/1.449, allocations: 65.7 kB / 0.7169 GB, free: 4.172 MB / 378.8 MB
Notification: Performance of collectInitialEqns (initialization): time 0.003873/1.453, allocations: 5.004 MB / 0.7218 GB, free: 15.69 MB / 394.8 MB
Notification: Performance of collectInitialBindings (initialization): time 0.00143/1.454, allocations: 1.132 MB / 0.7229 GB, free: 14.69 MB / 394.8 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0004314/1.454, allocations: 178.7 kB / 0.7231 GB, free: 14.52 MB / 394.8 MB
Notification: Performance of setup shared object (initialization): time 0.0004425/1.455, allocations: 0.6806 MB / 0.7237 GB, free: 13.94 MB / 394.8 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.00473/1.46, allocations: 3.279 MB / 0.7269 GB, free: 10.95 MB / 394.8 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.196/1.656, allocations: 8.525 MB / 0.7353 GB, free: 90.11 MB / 394.8 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.009349/1.665, allocations: 5.221 MB / 0.7404 GB, free: 90.09 MB / 394.8 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0002011/1.665, allocations: 55.25 kB / 0.7404 GB, free: 90.09 MB / 394.8 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.02794/1.693, allocations: 13.83 MB / 0.7539 GB, free: 88.88 MB / 394.8 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001105/1.693, allocations: 86.81 kB / 0.754 GB, free: 88.88 MB / 394.8 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0002414/1.694, allocations: 185.8 kB / 0.7542 GB, free: 88.88 MB / 394.8 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.006291/1.7, allocations: 2.268 MB / 0.7564 GB, free: 88.82 MB / 394.8 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.007155/1.707, allocations: 2.08 MB / 0.7584 GB, free: 88.64 MB / 394.8 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.01916/1.726, allocations: 20.15 MB / 0.7781 GB, free: 78.95 MB / 394.8 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.007882/1.734, allocations: 0.4993 MB / 0.7786 GB, free: 78.81 MB / 394.8 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001931/1.736, allocations: 0.5141 MB / 0.7791 GB, free: 78.74 MB / 394.8 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 ()
 * 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.001493/1.738, allocations: 0.7955 MB / 0.7799 GB, free: 78.21 MB / 394.8 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001056/1.739, allocations: 0.5259 MB / 0.7804 GB, free: 78.21 MB / 394.8 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01193/1.751, allocations: 7.08 MB / 0.7873 GB, free: 75.32 MB / 394.8 MB
Notification: Performance of postOpt inlineArrayEqn (simulation): time 4.894e-05/1.751, allocations: 42.42 kB / 0.7873 GB, free: 75.31 MB / 394.8 MB
Notification: Performance of postOpt constantLinearSystem (simulation): time 1.729e-05/1.751, allocations: 19.83 kB / 0.7874 GB, free: 75.31 MB / 394.8 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 2.337e-05/1.751, allocations: 17.73 kB / 0.7874 GB, free: 75.31 MB / 394.8 MB
Notification: Performance of postOpt removeSimpleEquations (simulation): time 0.02335/1.774, allocations: 15.3 MB / 0.8023 GB, free: 69.32 MB / 394.8 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.79e-05/1.774, allocations: 4 kB / 0.8023 GB, free: 69.32 MB / 394.8 MB
Notification: Performance of postOpt solveSimpleEquations (simulation): time 0.002749/1.777, allocations: 0.523 MB / 0.8028 GB, free: 69.28 MB / 394.8 MB
Notification: Performance of postOpt tearingSystem (simulation): time 0.005862/1.783, allocations: 2.065 MB / 0.8049 GB, free: 68.79 MB / 394.8 MB
Notification: Performance of postOpt inputDerivativesUsed (simulation): time 0.0004528/1.783, allocations: 55.47 kB / 0.8049 GB, free: 68.75 MB / 394.8 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (simulation): time 0.01878/1.802, allocations: 22.49 MB / 0.8269 GB, free: 49.73 MB / 394.8 MB
Notification: Performance of postOpt calculateStateSetsJacobians (simulation): time 3.947e-06/1.802, allocations: 7.812 kB / 0.8269 GB, free: 49.73 MB / 394.8 MB
Notification: Performance of postOpt symbolicJacobian (simulation): time 0.01555/1.818, allocations: 10.98 MB / 0.8376 GB, free: 40.17 MB / 394.8 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.002771/1.821, allocations: 1.008 MB / 0.8386 GB, free: 39.23 MB / 394.8 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0005839/1.821, allocations: 60.48 kB / 0.8386 GB, free: 39.18 MB / 394.8 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002183/1.823, allocations: 189.2 kB / 0.8388 GB, free: 39.06 MB / 394.8 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0005668/1.824, allocations: 177.6 kB / 0.839 GB, free: 38.95 MB / 394.8 MB
Notification: Performance of postOpt collapseArrayExpressions (simulation): time 0.0002113/1.824, allocations: 79.34 kB / 0.8391 GB, free: 38.88 MB / 394.8 MB
Notification: Performance of sorting global known variables: time 0.004991/1.829, allocations: 3.561 MB / 0.8425 GB, free: 35.72 MB / 394.8 MB
Notification: Performance of sort global known variables: time 2.6e-07/1.829, allocations: 3.938 kB / 0.8426 GB, free: 35.71 MB / 394.8 MB
Notification: Performance of remove unused functions: time 0.007296/1.836, allocations: 1.741 MB / 0.8443 GB, free: 34 MB / 394.8 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 ()
 * 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.0007006/1.837, allocations: 256.6 kB / 0.8445 GB, free: 33.77 MB / 394.8 MB
Notification: Performance of simCode: created initialization part: time 0.0123/1.849, allocations: 9.112 MB / 0.8534 GB, free: 25.34 MB / 394.8 MB
Notification: Performance of simCode: created event and clocks part: time 6.171e-06/1.85, allocations: 0 / 0.8534 GB, free: 25.34 MB / 394.8 MB
Notification: Performance of simCode: created simulation system equations: time 0.005699/1.855, allocations: 4.123 MB / 0.8574 GB, free: 21.48 MB / 394.8 MB
Notification: Performance of simCode: created of all other equations (e.g. parameter, nominal, assert, etc): time 0.003897/1.859, allocations: 0.7356 MB / 0.8581 GB, free: 20.88 MB / 394.8 MB
Notification: Performance of simCode: created linear, non-linear and system jacobian parts: time 0.02401/1.883, allocations: 13.31 MB / 0.8711 GB, free: 9.078 MB / 394.8 MB
Notification: Performance of simCode: some other stuff during SimCode phase: time 0.2112/2.094, allocations: 5.271 MB / 0.8763 GB, free: 79.32 MB / 394.8 MB
Notification: Performance of simCode: alias equations: time 0.01015/2.105, allocations: 2.739 MB / 0.879 GB, free: 79.26 MB / 394.8 MB
Notification: Performance of simCode: all other stuff during SimCode phase: time 0.001484/2.106, allocations: 345.8 kB / 0.8793 GB, free: 79.25 MB / 394.8 MB
Notification: Performance of SimCode: time 1.633e-06/2.106, allocations: 0 / 0.8793 GB, free: 79.25 MB / 394.8 MB
Notification: Performance of Templates: time 0.1134/2.22, allocations: 66.51 MB / 0.9442 GB, free: 63.41 MB / 394.8 MB
make -j1 -f Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.makefile
(rm -f Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.pipe ; mkfifo Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.pipe ; head -c 1048576 < Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.pipe >> ../files/Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.sim & ./Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint  -abortSlowSimulation -alarm=480 -lv LOG_STATS > Modelica_3.2.1_Modelica.Mechanics.MultiBody.Examples.Constraints.PrismaticConstraint.pipe 2>&1)