Running: ./testmodel.py --libraries=/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ --ompython_omhome=/usr ModelicaTest_3.2.2_ModelicaTest.MultiBody.Joints.JointUSP2.conf.json
Using package ModelicaTest with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo)
Using package ModelicaServices with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo)
Using package Modelica with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo)
Using package Complex with version 3.2.2 (/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo)
Running command: translateModel(ModelicaTest.MultiBody.Joints.JointUSP2,tolerance=1e-06,outputFormat="mat",numberOfIntervals=5000,variableFilter="time|revolute.phi|revolute.w",fileNamePrefix="ModelicaTest_3.2.2_ModelicaTest.MultiBody.Joints.JointUSP2")
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Complex 3.2.2+maint.om/package.mo): time 0.004203/0.004203, allocations: 364 kB / 15.96 MB, free: 6.203 MB / 13.93 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/Modelica 3.2.2+maint.om/package.mo): time 3.833/3.833, allocations: 388.9 MB / 405.6 MB, free: 10.24 MB / 346.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaServices 3.2.2+maint.om/package.mo): time 0.003565/0.003565, allocations: 229.6 kB / 451 MB, free: 145.1 MB / 346.7 MB
Notification: Performance of loadFile(/var/lib/hudson/saved_omc/libraries/.openmodelica/libraries/ModelicaTest 3.2.2+maint.om/package.mo): time 0.5807/0.5807, allocations: 80.03 MB / 0.5627 GB, free: 19.84 MB / 346.7 MB
Notification: Performance of FrontEnd - loaded program: time 0.000471/0.0004712, allocations: 16 kB / 0.6265 GB, free: 96.55 MB / 346.7 MB
Notification: Performance of FrontEnd - Absyn->SCode: time 0.09985/0.1003, allocations: 54.86 MB / 0.6801 GB, free: 41.67 MB / 346.7 MB
Notification: Performance of NFInst.instantiate(ModelicaTest.MultiBody.Joints.JointUSP2): time 0.3672/0.4676, allocations: 41.94 MB / 0.7211 GB, free: 11.92 MB / 346.7 MB
Notification: Performance of NFInst.instExpressions: time 0.02854/0.4962, allocations: 9.838 MB / 0.7307 GB, free: 11.68 MB / 346.7 MB
Notification: Performance of NFInst.updateImplicitVariability: time 0.01033/0.5066, allocations: 198.4 kB / 0.7309 GB, free: 11.65 MB / 346.7 MB
Notification: Performance of NFTyping.typeComponents: time 0.008142/0.5148, allocations: 1.998 MB / 0.7328 GB, free: 11.25 MB / 346.7 MB
Notification: Performance of NFTyping.typeBindings: time 0.03279/0.5476, allocations: 7.097 MB / 0.7397 GB, free: 9.172 MB / 346.7 MB
Notification: Performance of NFTyping.typeClassSections: time 0.008258/0.5559, allocations: 0.9682 MB / 0.7407 GB, free: 8.883 MB / 346.7 MB
Notification: Performance of NFFlatten.flatten: time 0.05083/0.6068, allocations: 17.26 MB / 0.7575 GB, free: 3.102 MB / 346.7 MB
Notification: Performance of NFFlatten.resolveConnections: time 0.01978/0.6267, allocations: 6.287 MB / 0.7637 GB, free: 14.53 MB / 362.7 MB
Notification: Performance of NFEvalConstants.evaluate: time 0.006669/0.6335, allocations: 1.66 MB / 0.7653 GB, free: 13.11 MB / 362.7 MB
Notification: Performance of NFSimplifyModel.simplify: time 0.009431/0.643, allocations: 2.674 MB / 0.7679 GB, free: 10.88 MB / 362.7 MB
Notification: Performance of NFPackage.collectConstants: time 0.002288/0.6453, allocations: 200 kB / 0.7681 GB, free: 10.69 MB / 362.7 MB
Notification: Performance of NFFlatten.collectFunctions: time 0.00731/0.6527, allocations: 1.265 MB / 0.7693 GB, free: 9.633 MB / 362.7 MB
Notification: Performance of NFScalarize.scalarize: time 0.006293/0.659, allocations: 2.281 MB / 0.7716 GB, free: 7.754 MB / 362.7 MB
Notification: Performance of NFVerifyModel.verify: time 0.003489/0.6626, allocations: 1.088 MB / 0.7726 GB, free: 7.164 MB / 362.7 MB
Notification: Performance of NFConvertDAE.convert: time 0.01892/0.6816, allocations: 7.743 MB / 0.7802 GB, free: 432 kB / 362.7 MB
Notification: Performance of FrontEnd - DAE generated: time 8.716e-06/0.6817, allocations: 0 / 0.7802 GB, free: 432 kB / 362.7 MB
Notification: Performance of FrontEnd: time 4.268e-06/0.6817, allocations: 0 / 0.7802 GB, free: 432 kB / 362.7 MB
Notification: Performance of Transformations before backend: time 0.000357/0.6821, allocations: 0 / 0.7802 GB, free: 432 kB / 362.7 MB
Notification: Model statistics after passing the front-end and creating the data structures used by the back-end:
 * Number of equations: 1929
 * Number of variables: 1929
Notification: Performance of Generate backend data structure: time 0.03056/0.7127, allocations: 5.637 MB / 0.7857 GB, free: 10.93 MB / 378.7 MB
Notification: Performance of prepare preOptimizeDAE: time 7.153e-05/0.7128, allocations: 8.031 kB / 0.7857 GB, free: 10.92 MB / 378.7 MB
Notification: Performance of preOpt normalInlineFunction (simulation): time 0.05072/0.7635, allocations: 3.143 MB / 0.7888 GB, free: 7.77 MB / 378.7 MB
Notification: Performance of preOpt evaluateParameters (simulation): time 0.01875/0.7823, allocations: 3.663 MB / 0.7923 GB, free: 4.098 MB / 378.7 MB
Notification: Performance of preOpt simplifyIfEquations (simulation): time 0.0007344/0.7831, allocations: 353.2 kB / 0.7927 GB, free: 3.785 MB / 378.7 MB
Notification: Performance of preOpt expandDerOperator (simulation): time 0.003234/0.7864, allocations: 428.8 kB / 0.7931 GB, free: 3.41 MB / 378.7 MB
Notification: Performance of preOpt clockPartitioning (simulation): time 0.06323/0.8497, allocations: 14.09 MB / 0.8068 GB, free: 4.594 MB / 394.7 MB
Notification: Performance of preOpt findStateOrder (simulation): time 0.0004148/0.8502, allocations: 55.52 kB / 0.8069 GB, free: 4.539 MB / 394.7 MB
Notification: Performance of preOpt replaceEdgeChange (simulation): time 0.002696/0.8529, allocations: 202.7 kB / 0.8071 GB, free: 4.387 MB / 394.7 MB
Notification: Performance of preOpt inlineArrayEqn (simulation): time 0.009104/0.8621, allocations: 2.348 MB / 0.8094 GB, free: 2.051 MB / 394.7 MB
Notification: Performance of preOpt removeEqualRHS (simulation): time 0.05604/0.9182, allocations: 11.96 MB / 0.8211 GB, free: 6.09 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.1065/1.025, allocations: 51.71 MB / 0.8716 GB, free: 1.215 MB / 458.7 MB
Notification: Performance of preOpt comSubExp (simulation): time 0.02262/1.047, allocations: 4.861 MB / 0.8763 GB, free: 12.19 MB / 474.7 MB
Notification: Performance of preOpt resolveLoops (simulation): time 0.00743/1.055, allocations: 2.975 MB / 0.8792 GB, free: 9.203 MB / 474.7 MB
Notification: Performance of preOpt evalFunc (simulation): time 0.03411/1.089, allocations: 12.91 MB / 0.8918 GB, free: 11.83 MB / 490.7 MB
Notification: Performance of preOpt encapsulateWhenConditions (simulation): time 7.343e-05/1.089, allocations: 55.86 kB / 0.8919 GB, free: 11.77 MB / 490.7 MB
Notification: Performance of pre-optimization done (n=199): time 7.183e-06/1.089, allocations: 0 / 0.8919 GB, free: 11.77 MB / 490.7 MB
Notification: Performance of matching and sorting (n=251): time 0.6644/1.754, allocations: 41.86 MB / 0.9328 GB, free: 162.7 MB / 490.7 MB
Notification: Performance of inlineWhenForInitialization (initialization): time 7.914e-05/1.754, allocations: 230.9 kB / 0.933 GB, free: 162.4 MB / 490.7 MB
Notification: Performance of selectInitializationVariablesDAE (initialization): time 0.0111/1.765, allocations: 4.743 MB / 0.9376 GB, free: 160 MB / 490.7 MB
Notification: Performance of collectPreVariables (initialization): time 0.0007729/1.766, allocations: 65.3 kB / 0.9377 GB, free: 159.9 MB / 490.7 MB
Notification: Performance of collectInitialEqns (initialization): time 0.00347/1.769, allocations: 3.805 MB / 0.9414 GB, free: 156.5 MB / 490.7 MB
Notification: Performance of collectInitialBindings (initialization): time 0.0018/1.771, allocations: 0.9485 MB / 0.9423 GB, free: 155.5 MB / 490.7 MB
Notification: Performance of simplifyInitialFunctions (initialization): time 0.001136/1.772, allocations: 149.1 kB / 0.9425 GB, free: 155.4 MB / 490.7 MB
Notification: Performance of setup shared object (initialization): time 0.0008155/1.773, allocations: 0.6121 MB / 0.943 GB, free: 154.8 MB / 490.7 MB
Notification: Performance of preBalanceInitialSystem (initialization): time 0.008924/1.782, allocations: 3.423 MB / 0.9464 GB, free: 151.4 MB / 490.7 MB
Notification: Performance of partitionIndependentBlocks (initialization): time 0.01121/1.793, allocations: 7.648 MB / 0.9539 GB, free: 141.7 MB / 490.7 MB
Notification: Performance of analyzeInitialSystem (initialization): time 0.01105/1.804, allocations: 4.952 MB / 0.9587 GB, free: 136.7 MB / 490.7 MB
Notification: Performance of solveInitialSystemEqSystem (initialization): time 0.000137/1.805, allocations: 44 kB / 0.9587 GB, free: 136.7 MB / 490.7 MB
Notification: Performance of matching and sorting (n=961) (initialization): time 0.04767/1.852, allocations: 14.39 MB / 0.9728 GB, free: 122.3 MB / 490.7 MB
Notification: Performance of prepare postOptimizeDAE: time 0.0001131/1.852, allocations: 68 kB / 0.9729 GB, free: 122.2 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (initialization): time 0.000206/1.853, allocations: 148 kB / 0.973 GB, free: 122.1 MB / 490.7 MB
Notification: Performance of postOpt tearingSystem (initialization): time 0.02196/1.875, allocations: 4.052 MB / 0.977 GB, free: 118 MB / 490.7 MB
Notification: Performance of postOpt solveSimpleEquations (initialization): time 0.009901/1.885, allocations: 1.623 MB / 0.9785 GB, free: 116.4 MB / 490.7 MB
Notification: Performance of postOpt calculateStrongComponentJacobians (initialization): time 0.044/1.929, allocations: 18.65 MB / 0.9968 GB, free: 97.58 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (initialization): time 0.009051/1.938, allocations: 453.8 kB / 0.9972 GB, free: 97.14 MB / 490.7 MB
Notification: Performance of postOpt collapseArrayExpressions (initialization): time 0.001556/1.939, allocations: 436.4 kB / 0.9976 GB, free: 96.72 MB / 490.7 MB
Notification: Model statistics after passing the back-end for initialization:
 * Number of independent subsystems: 673
 * Number of states: 0 ()
 * Number of discrete variables: 34 (jointUSP.prismatic.positiveBranch,bodyBox.color[3],bodyBox.color[2],bodyBox.color[1],bodyBox.body.sphereColor[3],bodyBox.body.sphereColor[2],bodyBox.body.sphereColor[1],revolute.cylinderColor[3],revolute.cylinderColor[2],revolute.cylinderColor[1],fixedTranslation.color[3],fixedTranslation.color[2],fixedTranslation.color[1],body.sphereColor[3],body.sphereColor[2],body.sphereColor[1],jointUSP.rod1Color[3],jointUSP.rod1Color[2],jointUSP.rod1Color[1],jointUSP.cylinderColor[3],jointUSP.cylinderColor[2],jointUSP.cylinderColor[1],jointUSP.sphereColor[3],jointUSP.sphereColor[2],jointUSP.sphereColor[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])
 * Number of discrete states: 0 ()
 * Number of clocked states: 0 ()
 * Top-level inputs: 0
Notification: Strong component statistics for initialization (880):
 * Single equations (assignments): 876
 * Array equations: 3
 * 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 {(2,100.0%) 56}
 * Non-linear torn systems: 0
Notification: Performance of prepare postOptimizeDAE: time 0.006953/1.946, allocations: 2.658 MB / 1 GB, free: 94.05 MB / 490.7 MB
Notification: Performance of postOpt lateInlineFunction (simulation): time 0.001194/1.948, allocations: 426.5 kB / 1.001 GB, free: 93.63 MB / 490.7 MB
Notification: Performance of postOpt wrapFunctionCalls (simulation): time 0.03291/1.98, allocations: 8.668 MB / 1.009 GB, free: 84.95 MB / 490.7 MB
Notification: Performance of postOpt simplifysemiLinear (simulation): time 6.867e-05/1.981, allocations: 11.97 kB / 1.009 GB, free: 84.93 MB / 490.7 MB
Notification: Performance of postOpt simplifyComplexFunction (simulation): time 1.245e-05/1.981, allocations: 3.953 kB / 1.009 GB, free: 84.93 MB / 490.7 MB
Notification: Performance of postOpt removeConstants (simulation): time 0.004067/1.985, allocations: 0.9757 MB / 1.01 GB, free: 83.93 MB / 490.7 MB
Notification: Performance of postOpt simplifyTimeIndepFuncCalls (simulation): time 0.001726/1.986, allocations: 36 kB / 1.01 GB, free: 83.89 MB / 490.7 MB
Notification: Performance of postOpt simplifyAllExpressions (simulation): time 0.004953/1.991, allocations: 191.7 kB / 1.01 GB, free: 83.71 MB / 490.7 MB
Notification: Performance of postOpt findZeroCrossings (simulation): time 0.00105/1.993, allocations: 201.6 kB / 1.01 GB, free: 83.51 MB / 490.7 MB
Notification: Performance of postOpt createDAEmodeBDAE (simulation): time 0.03163/2.024, allocations: 8.607 MB / 1.019 GB, free: 74.94 MB / 490.7 MB
Notification: Performance of postOpt detectDAEmodeSparsePattern (simulation): time 0.02024/2.045, allocations: 9.353 MB / 1.028 GB, free: 65.57 MB / 490.7 MB
Notification: Performance of postOpt setEvaluationStage (simulation): time 0.005351/2.05, allocations: 2.569 MB / 1.03 GB, free: 63 MB / 490.7 MB
Notification: Performance of sorting global known variables: time 0.006897/2.057, allocations: 2.961 MB / 1.033 GB, free: 60.04 MB / 490.7 MB
Notification: Performance of Backend: time 1.422e-06/2.057, allocations: 3.938 kB / 1.033 GB, free: 60.04 MB / 490.7 MB
Notification: Performance of simCode: created initialization part: time 0.01851/2.075, allocations: 6.168 MB / 1.039 GB, free: 53.92 MB / 490.7 MB
Notification: Performance of SimCode: time 0.02984/2.105, allocations: 13.94 MB / 1.053 GB, free: 39.93 MB / 490.7 MB
Notification: Performance of Templates: time 0.5324/2.638, allocations: 68.67 MB / 1.12 GB, free: 138.4 MB / 490.7 MB