Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.1_ModelicaTest.MultiBody.Joints.Planar.conf.json
Using package ModelicaTest with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo)
Using package ModelicaServices with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo)
Using package Modelica with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo)
Using package Complex with version 3.2.1 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo)
Running command: translateModel(ModelicaTest.MultiBody.Joints.Planar,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|planar.phi|planar.s_x|planar.s_y|planar.v_x|planar.v_y|planar.w",fileNamePrefix="ModelicaTest_3.2.1_ModelicaTest.MultiBody.Joints.Planar")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.1+maint.om/package.mo): time 0.002778/0.002783, allocations: 351.3 kB / 15.95 MB, free: 6.215 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.1+maint.om/package.mo): time 3.441/3.441, allocations: 341.5 MB / 358.2 MB, free: 12.64 MB / 298.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.1+maint.om/package.mo): time 0.003472/0.003472, allocations: 229.1 kB / 397.9 MB, free: 4.977 MB / 330.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.1+maint.om/package.mo): time 0.5292/0.5292, allocations: 76.09 MB / 0.5014 GB, free: 112.6 MB / 362.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.0004683/0.0004684, allocations: 12 kB / 0.5592 GB, free: 53.46 MB / 362.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.08514/0.08564, allocations: 48.7 MB / 0.6067 GB, free: 4.656 MB / 362.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.Planar): time 0.3376/0.4233, allocations: 40.99 MB / 0.6468 GB, free: 66.25 MB / 362.7 MB
Notification: Performance of NFInst.instExpressions: time 0.03157/0.455, allocations: 8.864 MB / 0.6554 GB, free: 60.31 MB / 362.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01121/0.4662, allocations: 182.8 kB / 0.6556 GB, free: 60.29 MB / 362.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.009862/0.4761, allocations: 2.013 MB / 0.6576 GB, free: 59.52 MB / 362.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.0245/0.5007, allocations: 6.88 MB / 0.6643 GB, free: 53.87 MB / 362.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.003734/0.5045, allocations: 0.5343 MB / 0.6648 GB, free: 53.33 MB / 362.7 MB
Notification: Performance of NFFlatten.flatten: time 0.007919/0.5125, allocations: 4.89 MB / 0.6696 GB, free: 48.44 MB / 362.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.006676/0.5192, allocations: 3.587 MB / 0.6731 GB, free: 44.89 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.002711/0.522, allocations: 1.346 MB / 0.6744 GB, free: 43.54 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.004091/0.5261, allocations: 2.134 MB / 0.6765 GB, free: 41.4 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.001048/0.5272, allocations: 172 kB / 0.6767 GB, free: 41.23 MB / 362.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.002901/0.5301, allocations: 0.8464 MB / 0.6775 GB, free: 40.39 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.002804/0.533, allocations: 1.835 MB / 0.6793 GB, free: 38.55 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.001375/0.5344, allocations: 0.9439 MB / 0.6802 GB, free: 37.59 MB / 362.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.008091/0.5425, allocations: 6.155 MB / 0.6862 GB, free: 31.43 MB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 6.983e-06/0.5426, allocations: 0 / 0.6862 GB, free: 31.43 MB / 362.7 MB
Notification: Performance of FrontEnd: time 3.246e-06/0.5426, allocations: 6.812 kB / 0.6862 GB, free: 31.42 MB / 362.7 MB
Notification: Performance of Transformations before backend: time 0.0002485/0.5428, allocations: 0 / 0.6862 GB, free: 31.42 MB / 362.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1910
 * Number of variables: 1910
Notification: Performance of Generate backend data structure: time 0.01219/0.555, allocations: 4.433 MB / 0.6905 GB, free: 26.92 MB / 362.7 MB
Notification: Performance of prepare preOptimizeDAE: time 5.029e-05/0.5551, allocations: 8.031 kB / 0.6905 GB, free: 26.91 MB / 362.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.02255/0.5777, allocations: 3.838 MB / 0.6943 GB, free: 23.06 MB / 362.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.006407/0.5841, allocations: 2.418 MB / 0.6967 GB, free: 20.6 MB / 362.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0002342/0.5844, allocations: 262.5 kB / 0.6969 GB, free: 20.34 MB / 362.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.001676/0.5861, allocations: 339.7 kB / 0.6972 GB, free: 20.01 MB / 362.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.02777/0.6139, allocations: 12.76 MB / 0.7097 GB, free: 6.723 MB / 362.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0001688/0.6141, allocations: 39.61 kB / 0.7097 GB, free: 6.684 MB / 362.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.001369/0.6155, allocations: 163.8 kB / 0.7099 GB, free: 6.523 MB / 362.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.007784/0.6233, allocations: 2.962 MB / 0.7128 GB, free: 3.559 MB / 362.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.03446/0.6578, allocations: 11.39 MB / 0.7239 GB, free: 8.16 MB / 378.7 MB
Notification: Performance of preOpt removeSimpleEquations (simulation): time 0.3698/1.028, allocations: 42.2 MB / 0.7651 GB, free: 109 MB / 410.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.01601/1.044, allocations: 4.697 MB / 0.7697 GB, free: 107.8 MB / 410.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.005691/1.049, allocations: 2.428 MB / 0.7721 GB, free: 107.8 MB / 410.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.001604/1.051, allocations: 1.311 MB / 0.7733 GB, free: 106.6 MB / 410.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 5.509e-05/1.051, allocations: 57.48 kB / 0.7734 GB, free: 106.6 MB / 410.7 MB
Notification: Performance of pre-optimization done (n=250): time 7.214e-06/1.051, allocations: 0 / 0.7734 GB, free: 106.6 MB / 410.7 MB
Notification: Performance of matching and sorting (n=268): time 0.07909/1.13, allocations: 19.48 MB / 0.7924 GB, free: 101.8 MB / 410.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 4.88e-05/1.13, allocations: 108.8 kB / 0.7925 GB, free: 101.8 MB / 410.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.005721/1.136, allocations: 3.205 MB / 0.7956 GB, free: 100.6 MB / 410.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0005098/1.137, allocations: 62.2 kB / 0.7957 GB, free: 100.5 MB / 410.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.002424/1.139, allocations: 3.271 MB / 0.7989 GB, free: 98.01 MB / 410.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.001349/1.141, allocations: 0.9818 MB / 0.7999 GB, free: 97.29 MB / 410.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.0005618/1.141, allocations: 119.7 kB / 0.8 GB, free: 97.2 MB / 410.7 MB
Notification: Performance of setup shared object (initialization): time 0.0003838/1.142, allocations: 0.5653 MB / 0.8005 GB, free: 96.78 MB / 410.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.005578/1.147, allocations: 2.477 MB / 0.8029 GB, free: 96 MB / 410.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.007953/1.155, allocations: 5.841 MB / 0.8087 GB, free: 90.76 MB / 410.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.008237/1.163, allocations: 3.785 MB / 0.8123 GB, free: 89.45 MB / 410.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.0001248/1.164, allocations: 33.75 kB / 0.8124 GB, free: 89.45 MB / 410.7 MB
Notification: Performance of matching and sorting (n=810) (initialization): time 0.03356/1.197, allocations: 9.086 MB / 0.8213 GB, free: 81.64 MB / 410.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001376/1.197, allocations: 59.95 kB / 0.8213 GB, free: 81.58 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.0001989/1.198, allocations: 116.1 kB / 0.8214 GB, free: 81.47 MB / 410.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.007978/1.206, allocations: 1.074 MB / 0.8225 GB, free: 80.39 MB / 410.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.008225/1.214, allocations: 1.388 MB / 0.8238 GB, free: 79 MB / 410.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.009984/1.224, allocations: 5.141 MB / 0.8288 GB, free: 73.73 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.005837/1.23, allocations: 332.6 kB / 0.8292 GB, free: 73.41 MB / 410.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001036/1.231, allocations: 352.9 kB / 0.8295 GB, free: 73.07 MB / 410.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 536
 * Number of states: 0 ()
 * Number of discrete variables: 39 (axis1.color[3],axis1.color[2],axis1.color[1],frame_a1.color_x[3],frame_a1.color_x[2],frame_a1.color_x[1],frame_a.color_x[3],frame_a.color_x[2],frame_a.color_x[1],body.sphereColor[3],body.sphereColor[2],body.sphereColor[1],planar.cylinderColor[3],planar.cylinderColor[2],planar.cylinderColor[1],planar.boxColor[3],planar.boxColor[2],planar.boxColor[1],planar.revolute.cylinderColor[3],planar.revolute.cylinderColor[2],planar.revolute.cylinderColor[1],planar.prismatic_y.boxColor[3],planar.prismatic_y.boxColor[2],planar.prismatic_y.boxColor[1],planar.prismatic_x.boxColor[3],planar.prismatic_x.boxColor[2],planar.prismatic_x.boxColor[1],axis2.color[3],axis2.color[2],axis2.color[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])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (748):
 * Single equations (assignments): 741
 * Array equations: 6
 * Algorithm blocks: 0
 * Record equations: 0
 * When equations: 0
 * If-equations: 0
 * Equation systems (linear and non-linear blocks): 0
 * Torn equation systems: 1
 * Mixed (continuous/discrete) equation systems: 0
Notification: Torn system details for strict tearing set:
 * Linear torn systems: 1 {(4,87.5%) 11}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.00566/1.237, allocations: 2.477 MB / 0.8319 GB, free: 70.59 MB / 410.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.0008461/1.237, allocations: 319.8 kB / 0.8322 GB, free: 70.27 MB / 410.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.01393/1.251, allocations: 5.363 MB / 0.8375 GB, free: 64.85 MB / 410.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 5.274e-05/1.251, allocations: 11.95 kB / 0.8375 GB, free: 64.84 MB / 410.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.114e-05/1.251, allocations: 3.953 kB / 0.8375 GB, free: 64.83 MB / 410.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.00237/1.254, allocations: 0.7195 MB / 0.8382 GB, free: 64.09 MB / 410.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.0008909/1.255, allocations: 36 kB / 0.8382 GB, free: 64.05 MB / 410.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.002508/1.257, allocations: 151.2 kB / 0.8384 GB, free: 63.91 MB / 410.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.0004611/1.258, allocations: 133.8 kB / 0.8385 GB, free: 63.78 MB / 410.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.01369/1.271, allocations: 4.904 MB / 0.8433 GB, free: 58.87 MB / 410.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.01362/1.285, allocations: 7.013 MB / 0.8501 GB, free: 51.78 MB / 410.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.003646/1.289, allocations: 1.921 MB / 0.852 GB, free: 49.86 MB / 410.7 MB
Notification: Performance of sorting global known variables: time 0.003785/1.293, allocations: 1.966 MB / 0.8539 GB, free: 47.9 MB / 410.7 MB
Notification: Performance of Backend: time 1.363e-06/1.293, allocations: 0 / 0.8539 GB, free: 47.9 MB / 410.7 MB
Notification: Performance of simCode: created initialization part: time 0.01208/1.305, allocations: 4.518 MB / 0.8583 GB, free: 43.43 MB / 410.7 MB
Notification: Performance of SimCode: time 0.02457/1.329, allocations: 12.69 MB / 0.8707 GB, free: 30.75 MB / 410.7 MB
Notification: Performance of Templates: time 0.1785/1.508, allocations: 45.23 MB / 0.9149 GB, free: 2.074 MB / 426.7 MB